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

• parent_buildername:publish_tarball
• user_agent:recipe

[05:59:30.179] New invocation is queued and will start shortly
[05:59:30.179] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[05:59:31.300] Starting the invocation (attempt 1)
[05:59:31.337] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:59:31.338] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:59:31.338] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9039437577109174720",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4209.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"485602dd-d265-4d66-bd53-dda9a4b23582\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4209.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:9039437577109174720",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[05:59:32.032] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1595483971448651",
    "id": "8874007515113407744",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4209.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"485602dd-d265-4d66-bd53-dda9a4b23582\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4209.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1595483971815764",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9039437577109174720",
      "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/8874007515113407744/+/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": "1595483971815925",
    "url": "https://ci.chromium.org/b/8874007515113407744",
    "utcnow_ts": "1595483972024079"
  }
}
[05:59:32.032] Task URL: https://ci.chromium.org/b/8874007515113407744
[05:59:32.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:2:0) after 1m0s
[05:59:54.866] Received PubSub notification, asking Buildbucket for the build status
[05:59:55.159] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:32.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:2:0)
[06:00:32.148] Timer tick, asking Buildbucket for the build status
[06:00:32.393] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:32.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:4:0) after 1m0s
[06:01:32.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:4:0)
[06:01:32.443] Timer tick, asking Buildbucket for the build status
[06:01:32.619] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:32.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:5:0) after 1m0s
[06:02:32.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:5:0)
[06:02:32.644] Timer tick, asking Buildbucket for the build status
[06:02:32.938] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:32.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:6:0) after 1m0s
[06:03:32.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:6:0)
[06:03:32.941] Timer tick, asking Buildbucket for the build status
[06:03:33.309] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:33.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:7:0) after 1m0s
[06:04:33.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:7:0)
[06:04:33.382] Timer tick, asking Buildbucket for the build status
[06:04:33.484] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:33.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:8:0) after 1m0s
[06:05:33.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:8:0)
[06:05:33.544] Timer tick, asking Buildbucket for the build status
[06:05:33.772] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:33.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:9:0) after 1m0s
[06:06:33.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:9:0)
[06:06:33.830] Timer tick, asking Buildbucket for the build status
[06:06:33.980] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:33.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:10:0) after 1m0s
[06:07:34.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:10:0)
[06:07:34.099] Timer tick, asking Buildbucket for the build status
[06:07:34.220] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:34.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:11:0) after 1m0s
[06:08:34.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:11:0)
[06:08:34.248] Timer tick, asking Buildbucket for the build status
[06:08:34.463] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:34.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:12:0) after 1m0s
[06:09:34.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:12:0)
[06:09:34.490] Timer tick, asking Buildbucket for the build status
[06:09:34.655] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:34.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:13:0) after 1m0s
[06:10:34.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:13:0)
[06:10:34.756] Timer tick, asking Buildbucket for the build status
[06:10:34.856] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:34.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:14:0) after 1m0s
[06:11:34.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:14:0)
[06:11:34.911] Timer tick, asking Buildbucket for the build status
[06:11:34.999] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:34.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:15:0) after 1m0s
[06:12:35.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:15:0)
[06:12:35.185] Timer tick, asking Buildbucket for the build status
[06:12:35.541] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:35.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:16:0) after 1m0s
[06:13:35.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:16:0)
[06:13:35.554] Timer tick, asking Buildbucket for the build status
[06:13:35.646] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:35.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:17:0) after 1m0s
[06:14:35.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:17:0)
[06:14:35.666] Timer tick, asking Buildbucket for the build status
[06:14:35.930] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:35.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:18:0) after 1m0s
[06:15:36.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:18:0)
[06:15:36.017] Timer tick, asking Buildbucket for the build status
[06:15:36.939] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:36.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:19:0) after 1m0s
[06:16:36.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:19:0)
[06:16:36.966] Timer tick, asking Buildbucket for the build status
[06:16:37.118] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:37.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:20:0) after 1m0s
[06:17:37.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:20:0)
[06:17:37.150] Timer tick, asking Buildbucket for the build status
[06:17:37.273] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:37.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:21:0) after 1m0s
[06:18:37.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:21:0)
[06:18:37.302] Timer tick, asking Buildbucket for the build status
[06:18:37.553] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:37.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:22:0) after 1m0s
[06:19:37.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:22:0)
[06:19:37.674] Timer tick, asking Buildbucket for the build status
[06:19:37.891] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:37.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:23:0) after 1m0s
[06:20:37.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:23:0)
[06:20:37.955] Timer tick, asking Buildbucket for the build status
[06:20:38.043] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:38.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:24:0) after 1m0s
[06:21:38.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:24:0)
[06:21:38.100] Timer tick, asking Buildbucket for the build status
[06:21:38.279] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:38.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:25:0) after 1m0s
[06:22:38.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:25:0)
[06:22:38.300] Timer tick, asking Buildbucket for the build status
[06:22:38.415] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:38.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:26:0) after 1m0s
[06:23:38.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:26:0)
[06:23:38.502] Timer tick, asking Buildbucket for the build status
[06:23:38.682] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:38.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:27:0) after 1m0s
[06:24:38.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:27:0)
[06:24:38.838] Timer tick, asking Buildbucket for the build status
[06:24:38.984] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:38.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:28:0) after 1m0s
[06:25:39.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:28:0)
[06:25:39.099] Timer tick, asking Buildbucket for the build status
[06:25:39.167] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:39.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:29:0) after 1m0s
[06:26:39.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:29:0)
[06:26:39.244] Timer tick, asking Buildbucket for the build status
[06:26:39.368] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:39.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:30:0) after 1m0s
[06:27:39.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:30:0)
[06:27:39.474] Timer tick, asking Buildbucket for the build status
[06:27:39.531] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:39.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:31:0) after 1m0s
[06:28:39.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:31:0)
[06:28:39.614] Timer tick, asking Buildbucket for the build status
[06:28:39.719] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:39.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:32:0) after 1m0s
[06:29:39.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:32:0)
[06:29:39.838] Timer tick, asking Buildbucket for the build status
[06:29:39.967] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:39.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:33:0) after 1m0s
[06:30:40.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:33:0)
[06:30:40.089] Timer tick, asking Buildbucket for the build status
[06:30:40.206] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:40.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:34:0) after 1m0s
[06:31:40.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:34:0)
[06:31:40.315] Timer tick, asking Buildbucket for the build status
[06:31:40.402] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:40.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:35:0) after 1m0s
[06:32:40.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:35:0)
[06:32:40.529] Timer tick, asking Buildbucket for the build status
[06:32:40.601] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:40.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:36:0) after 1m0s
[06:33:40.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:36:0)
[06:33:40.638] Timer tick, asking Buildbucket for the build status
[06:33:40.738] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:40.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:37:0) after 1m0s
[06:34:40.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:37:0)
[06:34:40.808] Timer tick, asking Buildbucket for the build status
[06:34:41.025] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:41.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:38:0) after 1m0s
[06:35:41.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:38:0)
[06:35:41.049] Timer tick, asking Buildbucket for the build status
[06:35:41.376] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:41.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:39:0) after 1m0s
[06:36:41.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:39:0)
[06:36:41.370] Timer tick, asking Buildbucket for the build status
[06:36:41.449] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:41.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:40:0) after 1m0s
[06:37:41.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:40:0)
[06:37:41.487] Timer tick, asking Buildbucket for the build status
[06:37:41.560] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:41.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:41:0) after 1m0s
[06:38:41.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:41:0)
[06:38:41.588] Timer tick, asking Buildbucket for the build status
[06:38:41.674] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:41.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:42:0) after 1m0s
[06:39:41.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:42:0)
[06:39:41.705] Timer tick, asking Buildbucket for the build status
[06:39:42.003] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:42.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:43:0) after 1m0s
[06:40:42.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:43:0)
[06:40:42.027] Timer tick, asking Buildbucket for the build status
[06:40:42.219] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:42.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:44:0) after 1m0s
[06:41:42.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:44:0)
[06:41:42.243] Timer tick, asking Buildbucket for the build status
[06:41:42.322] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:42.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:45:0) after 1m0s
[06:42:42.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:45:0)
[06:42:42.361] Timer tick, asking Buildbucket for the build status
[06:42:42.434] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:42.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:46:0) after 1m0s
[06:43:42.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:46:0)
[06:43:42.456] Timer tick, asking Buildbucket for the build status
[06:43:42.622] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:42.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:47:0) after 1m0s
[06:44:42.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:47:0)
[06:44:42.796] Timer tick, asking Buildbucket for the build status
[06:44:42.996] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:42.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:48:0) after 1m0s
[06:45:43.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:48:0)
[06:45:43.071] Timer tick, asking Buildbucket for the build status
[06:45:43.264] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:43.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:49:0) after 1m0s
[06:46:43.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:49:0)
[06:46:43.265] Timer tick, asking Buildbucket for the build status
[06:46:43.341] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:43.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:50:0) after 1m0s
[06:47:43.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:50:0)
[06:47:43.439] Timer tick, asking Buildbucket for the build status
[06:47:43.513] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:43.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:51:0) after 1m0s
[06:48:43.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:51:0)
[06:48:43.558] Timer tick, asking Buildbucket for the build status
[06:48:43.823] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:43.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:52:0) after 1m0s
[06:49:43.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:52:0)
[06:49:43.850] Timer tick, asking Buildbucket for the build status
[06:49:43.965] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:43.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:53:0) after 1m0s
[06:50:43.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:53:0)
[06:50:43.991] Timer tick, asking Buildbucket for the build status
[06:50:44.164] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:44.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:54:0) after 1m0s
[06:51:44.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:54:0)
[06:51:44.208] Timer tick, asking Buildbucket for the build status
[06:51:44.285] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:44.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:55:0) after 1m0s
[06:52:44.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:55:0)
[06:52:44.455] Timer tick, asking Buildbucket for the build status
[06:52:45.267] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:45.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:56:0) after 1m0s
[06:53:45.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:56:0)
[06:53:45.294] Timer tick, asking Buildbucket for the build status
[06:53:45.403] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:45.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:57:0) after 1m0s
[06:54:45.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:57:0)
[06:54:45.455] Timer tick, asking Buildbucket for the build status
[06:54:45.591] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:45.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:58:0) after 1m0s
[06:55:45.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:58:0)
[06:55:45.650] Timer tick, asking Buildbucket for the build status
[06:55:45.805] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:45.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:59:0) after 1m0s
[06:56:45.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:59:0)
[06:56:45.854] Timer tick, asking Buildbucket for the build status
[06:56:45.932] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:45.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:60:0) after 1m0s
[06:57:46.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:60:0)
[06:57:46.057] Timer tick, asking Buildbucket for the build status
[06:57:46.149] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:46.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:61:0) after 1m0s
[06:58:46.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:61:0)
[06:58:46.405] Timer tick, asking Buildbucket for the build status
[06:58:46.603] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:46.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:62:0) after 1m0s
[06:59:46.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:62:0)
[06:59:46.677] Timer tick, asking Buildbucket for the build status
[06:59:46.791] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:46.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:63:0) after 1m0s
[07:00:46.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:63:0)
[07:00:46.904] Timer tick, asking Buildbucket for the build status
[07:00:47.029] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:47.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:64:0) after 1m0s
[07:01:47.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:64:0)
[07:01:47.175] Timer tick, asking Buildbucket for the build status
[07:01:47.355] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:47.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:65:0) after 1m0s
[07:02:47.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:65:0)
[07:02:47.415] Timer tick, asking Buildbucket for the build status
[07:02:47.508] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:47.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:66:0) after 1m0s
[07:03:47.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:66:0)
[07:03:47.775] Timer tick, asking Buildbucket for the build status
[07:03:47.872] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:47.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:67:0) after 1m0s
[07:04:47.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:67:0)
[07:04:47.921] Timer tick, asking Buildbucket for the build status
[07:04:48.840] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:48.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:68:0) after 1m0s
[07:05:48.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:68:0)
[07:05:48.892] Timer tick, asking Buildbucket for the build status
[07:05:48.978] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:48.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:69:0) after 1m0s
[07:06:49.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:69:0)
[07:06:49.091] Timer tick, asking Buildbucket for the build status
[07:06:49.156] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:49.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:70:0) after 1m0s
[07:07:49.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:70:0)
[07:07:49.232] Timer tick, asking Buildbucket for the build status
[07:07:49.319] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:49.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:71:0) after 1m0s
[07:08:49.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:71:0)
[07:08:49.379] Timer tick, asking Buildbucket for the build status
[07:08:49.526] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:49.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:72:0) after 1m0s
[07:09:49.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:72:0)
[07:09:49.595] Timer tick, asking Buildbucket for the build status
[07:09:49.887] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:49.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:73:0) after 1m0s
[07:10:49.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:73:0)
[07:10:49.994] Timer tick, asking Buildbucket for the build status
[07:10:50.238] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:50.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:74:0) after 1m0s
[07:11:50.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:74:0)
[07:11:50.264] Timer tick, asking Buildbucket for the build status
[07:11:50.356] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:50.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:75:0) after 1m0s
[07:12:50.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:75:0)
[07:12:50.515] Timer tick, asking Buildbucket for the build status
[07:12:50.650] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:50.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:76:0) after 1m0s
[07:13:50.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:76:0)
[07:13:50.766] Timer tick, asking Buildbucket for the build status
[07:13:50.850] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:50.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:77:0) after 1m0s
[07:14:50.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:77:0)
[07:14:50.947] Timer tick, asking Buildbucket for the build status
[07:14:51.151] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:51.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:78:0) after 1m0s
[07:15:51.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:78:0)
[07:15:51.244] Timer tick, asking Buildbucket for the build status
[07:15:51.336] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:51.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:79:0) after 1m0s
[07:16:51.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:79:0)
[07:16:51.311] Timer tick, asking Buildbucket for the build status
[07:16:51.425] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:51.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:80:0) after 1m0s
[07:17:51.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:80:0)
[07:17:51.477] Timer tick, asking Buildbucket for the build status
[07:17:51.627] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:51.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:81:0) after 1m0s
[07:18:51.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:81:0)
[07:18:51.662] Timer tick, asking Buildbucket for the build status
[07:18:53.723] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:53.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:82:0) after 1m0s
[07:19:53.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:82:0)
[07:19:53.764] Timer tick, asking Buildbucket for the build status
[07:19:53.937] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:53.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:83:0) after 1m0s
[07:20:54.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:83:0)
[07:20:54.002] Timer tick, asking Buildbucket for the build status
[07:20:54.173] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:54.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:84:0) after 1m0s
[07:21:54.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:84:0)
[07:21:54.234] Timer tick, asking Buildbucket for the build status
[07:21:54.311] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:54.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:85:0) after 1m0s
[07:22:54.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:85:0)
[07:22:54.398] Timer tick, asking Buildbucket for the build status
[07:22:54.917] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:54.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:86:0) after 1m0s
[07:23:54.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:86:0)
[07:23:54.946] Timer tick, asking Buildbucket for the build status
[07:23:55.033] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:55.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:87:0) after 1m0s
[07:24:55.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:87:0)
[07:24:55.079] Timer tick, asking Buildbucket for the build status
[07:24:55.243] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:55.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:88:0) after 1m0s
[07:25:55.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:88:0)
[07:25:55.361] Timer tick, asking Buildbucket for the build status
[07:25:55.451] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:55.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:89:0) after 1m0s
[07:26:55.509] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:89:0)
[07:26:55.509] Timer tick, asking Buildbucket for the build status
[07:26:55.579] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:55.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:90:0) after 1m0s
[07:27:55.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:90:0)
[07:27:55.664] Timer tick, asking Buildbucket for the build status
[07:27:55.754] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:55.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:91:0) after 1m0s
[07:28:55.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:91:0)
[07:28:55.814] Timer tick, asking Buildbucket for the build status
[07:28:55.944] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:55.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:92:0) after 1m0s
[07:29:55.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:92:0)
[07:29:55.974] Timer tick, asking Buildbucket for the build status
[07:29:56.147] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:56.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:93:0) after 1m0s
[07:30:56.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:93:0)
[07:30:56.198] Timer tick, asking Buildbucket for the build status
[07:30:56.296] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:56.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:94:0) after 1m0s
[07:31:56.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:94:0)
[07:31:56.330] Timer tick, asking Buildbucket for the build status
[07:31:56.561] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:56.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:95:0) after 1m0s
[07:32:56.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:95:0)
[07:32:56.610] Timer tick, asking Buildbucket for the build status
[07:32:56.829] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:56.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:96:0) after 1m0s
[07:33:56.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:96:0)
[07:33:56.858] Timer tick, asking Buildbucket for the build status
[07:33:57.203] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:57.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:97:0) after 1m0s
[07:34:57.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:97:0)
[07:34:57.246] Timer tick, asking Buildbucket for the build status
[07:34:57.391] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:57.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:98:0) after 1m0s
[07:35:57.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:98:0)
[07:35:57.427] Timer tick, asking Buildbucket for the build status
[07:35:57.500] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:57.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:99:0) after 1m0s
[07:36:57.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:99:0)
[07:36:57.527] Timer tick, asking Buildbucket for the build status
[07:36:58.162] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:58.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:100:0) after 1m0s
[07:37:58.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:100:0)
[07:37:58.194] Timer tick, asking Buildbucket for the build status
[07:37:58.572] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:58.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:101:0) after 1m0s
[07:38:58.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:101:0)
[07:38:58.605] Timer tick, asking Buildbucket for the build status
[07:38:58.664] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:58.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:102:0) after 1m0s
[07:39:58.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:102:0)
[07:39:58.759] Timer tick, asking Buildbucket for the build status
[07:39:59.084] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:59.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:103:0) after 1m0s
[07:40:59.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:103:0)
[07:40:59.131] Timer tick, asking Buildbucket for the build status
[07:40:59.221] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:59.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:104:0) after 1m0s
[07:41:59.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:104:0)
[07:41:59.316] Timer tick, asking Buildbucket for the build status
[07:41:59.417] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:59.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:105:0) after 1m0s
[07:42:59.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:105:0)
[07:42:59.433] Timer tick, asking Buildbucket for the build status
[07:42:59.563] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:59.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:106:0) after 1m0s
[07:43:59.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:106:0)
[07:43:59.650] Timer tick, asking Buildbucket for the build status
[07:43:59.712] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:59.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:107:0) after 1m0s
[07:44:59.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:107:0)
[07:44:59.773] Timer tick, asking Buildbucket for the build status
[07:45:00.214] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:00.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:108:0) after 1m0s
[07:46:00.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:108:0)
[07:46:00.274] Timer tick, asking Buildbucket for the build status
[07:46:00.479] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:00.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:109:0) after 1m0s
[07:47:00.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:109:0)
[07:47:00.499] Timer tick, asking Buildbucket for the build status
[07:47:00.726] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:00.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:110:0) after 1m0s
[07:48:01.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:110:0)
[07:48:01.241] Timer tick, asking Buildbucket for the build status
[07:48:01.696] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:01.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:111:0) after 1m0s
[07:49:01.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:111:0)
[07:49:01.725] Timer tick, asking Buildbucket for the build status
[07:49:01.885] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:01.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:112:0) after 1m0s
[07:50:01.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:112:0)
[07:50:01.913] Timer tick, asking Buildbucket for the build status
[07:50:02.093] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:02.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:113:0) after 1m0s
[07:51:02.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:113:0)
[07:51:02.139] Timer tick, asking Buildbucket for the build status
[07:51:02.327] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:02.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:114:0) after 1m0s
[07:52:02.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:114:0)
[07:52:02.380] Timer tick, asking Buildbucket for the build status
[07:52:02.498] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:02.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:115:0) after 1m0s
[07:53:02.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:115:0)
[07:53:02.609] Timer tick, asking Buildbucket for the build status
[07:53:02.707] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:02.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:116:0) after 1m0s
[07:54:02.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:116:0)
[07:54:02.872] Timer tick, asking Buildbucket for the build status
[07:54:02.992] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:02.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:117:0) after 1m0s
[07:55:03.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:117:0)
[07:55:03.038] Timer tick, asking Buildbucket for the build status
[07:55:03.176] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:03.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:118:0) after 1m0s
[07:56:03.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:118:0)
[07:56:03.222] Timer tick, asking Buildbucket for the build status
[07:56:03.420] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:03.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:119:0) after 1m0s
[07:57:03.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:119:0)
[07:57:03.446] Timer tick, asking Buildbucket for the build status
[07:57:03.768] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:03.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:120:0) after 1m0s
[07:58:03.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:120:0)
[07:58:03.823] Timer tick, asking Buildbucket for the build status
[07:58:04.153] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:04.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:121:0) after 1m0s
[07:59:04.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:121:0)
[07:59:04.217] Timer tick, asking Buildbucket for the build status
[07:59:04.400] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:04.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:122:0) after 1m0s
[08:00:04.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:122:0)
[08:00:04.447] Timer tick, asking Buildbucket for the build status
[08:00:04.623] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:04.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:123:0) after 1m0s
[08:01:04.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:123:0)
[08:01:04.726] Timer tick, asking Buildbucket for the build status
[08:01:04.822] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:04.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:124:0) after 1m0s
[08:02:04.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:124:0)
[08:02:04.880] Timer tick, asking Buildbucket for the build status
[08:02:05.042] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:05.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:125:0) after 1m0s
[08:03:05.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:125:0)
[08:03:05.038] Timer tick, asking Buildbucket for the build status
[08:03:05.791] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:05.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:126:0) after 1m0s
[08:04:05.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:126:0)
[08:04:05.972] Timer tick, asking Buildbucket for the build status
[08:04:06.079] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:06.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:127:0) after 1m0s
[08:05:06.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:127:0)
[08:05:06.374] Timer tick, asking Buildbucket for the build status
[08:05:06.519] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:06.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:128:0) after 1m0s
[08:06:06.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:128:0)
[08:06:06.655] Timer tick, asking Buildbucket for the build status
[08:06:06.783] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:06.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:129:0) after 1m0s
[08:07:07.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:129:0)
[08:07:07.063] Timer tick, asking Buildbucket for the build status
[08:07:07.145] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:07.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:130:0) after 1m0s
[08:08:07.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:130:0)
[08:08:07.376] Timer tick, asking Buildbucket for the build status
[08:08:07.445] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:07.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:131:0) after 1m0s
[08:09:07.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:131:0)
[08:09:07.619] Timer tick, asking Buildbucket for the build status
[08:09:07.929] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:07.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:132:0) after 1m0s
[08:10:08.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:132:0)
[08:10:08.261] Timer tick, asking Buildbucket for the build status
[08:10:08.626] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:08.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:133:0) after 1m0s
[08:11:09.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:133:0)
[08:11:09.073] Timer tick, asking Buildbucket for the build status
[08:11:09.167] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:09.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:134:0) after 1m0s
[08:12:09.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:134:0)
[08:12:09.221] Timer tick, asking Buildbucket for the build status
[08:12:09.309] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:09.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:135:0) after 1m0s
[08:13:09.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:135:0)
[08:13:09.506] Timer tick, asking Buildbucket for the build status
[08:13:09.593] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:09.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:136:0) after 1m0s
[08:14:09.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:136:0)
[08:14:09.635] Timer tick, asking Buildbucket for the build status
[08:14:09.854] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:09.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:137:0) after 1m0s
[08:15:09.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:137:0)
[08:15:09.997] Timer tick, asking Buildbucket for the build status
[08:15:10.149] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:10.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:138:0) after 1m0s
[08:16:10.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:138:0)
[08:16:10.247] Timer tick, asking Buildbucket for the build status
[08:16:10.333] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:10.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:139:0) after 1m0s
[08:17:10.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:139:0)
[08:17:10.363] Timer tick, asking Buildbucket for the build status
[08:17:10.606] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:10.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:140:0) after 1m0s
[08:18:10.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:140:0)
[08:18:10.862] Timer tick, asking Buildbucket for the build status
[08:18:11.019] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:11.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:141:0) after 1m0s
[08:19:11.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:141:0)
[08:19:11.112] Timer tick, asking Buildbucket for the build status
[08:19:11.184] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:11.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:142:0) after 1m0s
[08:20:11.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:142:0)
[08:20:11.359] Timer tick, asking Buildbucket for the build status
[08:20:11.480] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:11.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:143:0) after 1m0s
[08:21:11.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:143:0)
[08:21:11.565] Timer tick, asking Buildbucket for the build status
[08:21:11.791] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:11.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:144:0) after 1m0s
[08:22:11.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:144:0)
[08:22:11.823] Timer tick, asking Buildbucket for the build status
[08:22:11.930] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:11.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:145:0) after 1m0s
[08:23:11.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:145:0)
[08:23:11.964] Timer tick, asking Buildbucket for the build status
[08:23:12.231] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:12.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:146:0) after 1m0s
[08:24:12.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:146:0)
[08:24:12.278] Timer tick, asking Buildbucket for the build status
[08:24:12.388] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:12.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:147:0) after 1m0s
[08:25:12.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:147:0)
[08:25:12.436] Timer tick, asking Buildbucket for the build status
[08:25:12.944] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:12.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:148:0) after 1m0s
[08:26:12.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:148:0)
[08:26:12.997] Timer tick, asking Buildbucket for the build status
[08:26:13.101] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:13.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:149:0) after 1m0s
[08:27:13.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:149:0)
[08:27:13.133] Timer tick, asking Buildbucket for the build status
[08:27:14.683] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:14.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:150:0) after 1m0s
[08:28:14.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:150:0)
[08:28:14.726] Timer tick, asking Buildbucket for the build status
[08:28:14.845] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:14.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:151:0) after 1m0s
[08:29:14.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:151:0)
[08:29:14.845] Timer tick, asking Buildbucket for the build status
[08:29:15.074] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:15.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:152:0) after 1m0s
[08:30:15.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:152:0)
[08:30:15.155] Timer tick, asking Buildbucket for the build status
[08:30:15.491] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:15.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:153:0) after 1m0s
[08:31:15.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:153:0)
[08:31:15.630] Timer tick, asking Buildbucket for the build status
[08:31:15.727] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:15.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:154:0) after 1m0s
[08:32:15.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:154:0)
[08:32:15.794] Timer tick, asking Buildbucket for the build status
[08:32:15.862] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:15.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:155:0) after 1m0s
[08:33:15.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:155:0)
[08:33:15.855] Timer tick, asking Buildbucket for the build status
[08:33:15.943] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:15.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:156:0) after 1m0s
[08:34:16.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:156:0)
[08:34:16.047] Timer tick, asking Buildbucket for the build status
[08:34:16.255] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:16.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:157:0) after 1m0s
[08:35:16.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:157:0)
[08:35:16.284] Timer tick, asking Buildbucket for the build status
[08:35:16.488] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:16.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:158:0) after 1m0s
[08:36:16.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:158:0)
[08:36:16.582] Timer tick, asking Buildbucket for the build status
[08:36:16.719] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:16.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:159:0) after 1m0s
[08:37:16.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:159:0)
[08:37:16.822] Timer tick, asking Buildbucket for the build status
[08:37:16.898] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:16.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:160:0) after 1m0s
[08:38:16.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:160:0)
[08:38:16.927] Timer tick, asking Buildbucket for the build status
[08:38:17.125] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:17.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:161:0) after 1m0s
[08:39:17.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:161:0)
[08:39:17.233] Timer tick, asking Buildbucket for the build status
[08:39:17.329] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:17.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:162:0) after 1m0s
[08:40:17.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:162:0)
[08:40:17.481] Timer tick, asking Buildbucket for the build status
[08:40:18.551] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:18.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:163:0) after 1m0s
[08:41:18.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:163:0)
[08:41:18.634] Timer tick, asking Buildbucket for the build status
[08:41:18.726] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:18.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:164:0) after 1m0s
[08:42:18.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:164:0)
[08:42:18.796] Timer tick, asking Buildbucket for the build status
[08:42:18.871] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:18.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:165:0) after 1m0s
[08:43:18.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:165:0)
[08:43:18.927] Timer tick, asking Buildbucket for the build status
[08:43:18.998] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:18.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:166:0) after 1m0s
[08:44:19.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:166:0)
[08:44:19.082] Timer tick, asking Buildbucket for the build status
[08:44:19.389] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:19.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:167:0) after 1m0s
[08:45:19.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:167:0)
[08:45:19.432] Timer tick, asking Buildbucket for the build status
[08:45:19.605] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:19.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:168:0) after 1m0s
[08:46:19.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:168:0)
[08:46:19.639] Timer tick, asking Buildbucket for the build status
[08:46:20.145] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:20.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:169:0) after 1m0s
[08:47:20.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:169:0)
[08:47:20.551] Timer tick, asking Buildbucket for the build status
[08:47:20.796] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:20.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:170:0) after 1m0s
[08:48:20.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:170:0)
[08:48:20.805] Timer tick, asking Buildbucket for the build status
[08:48:20.867] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:20.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:171:0) after 1m0s
[08:49:21.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:171:0)
[08:49:21.106] Timer tick, asking Buildbucket for the build status
[08:49:21.856] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:21.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:172:0) after 1m0s
[08:50:21.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:172:0)
[08:50:21.895] Timer tick, asking Buildbucket for the build status
[08:50:22.214] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:22.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:173:0) after 1m0s
[08:51:22.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:173:0)
[08:51:22.345] Timer tick, asking Buildbucket for the build status
[08:51:22.458] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:22.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:174:0) after 1m0s
[08:52:22.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:174:0)
[08:52:22.488] Timer tick, asking Buildbucket for the build status
[08:52:22.580] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:22.580] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:175:0) after 1m0s
[08:53:22.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:175:0)
[08:53:22.684] Timer tick, asking Buildbucket for the build status
[08:53:22.903] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:22.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:176:0) after 1m0s
[08:54:22.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:176:0)
[08:54:22.938] Timer tick, asking Buildbucket for the build status
[08:54:23.024] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:23.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:177:0) after 1m0s
[08:55:23.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:177:0)
[08:55:23.091] Timer tick, asking Buildbucket for the build status
[08:55:23.396] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:23.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:178:0) after 1m0s
[08:56:23.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:178:0)
[08:56:23.424] Timer tick, asking Buildbucket for the build status
[08:56:23.536] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:23.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:179:0) after 1m0s
[08:57:23.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:179:0)
[08:57:23.592] Timer tick, asking Buildbucket for the build status
[08:57:23.786] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:23.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:180:0) after 1m0s
[08:58:23.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:180:0)
[08:58:23.872] Timer tick, asking Buildbucket for the build status
[08:58:24.301] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:24.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:181:0) after 1m0s
[08:59:24.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:181:0)
[08:59:24.371] Timer tick, asking Buildbucket for the build status
[08:59:24.502] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:24.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:182:0) after 1m0s
[09:00:24.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:182:0)
[09:00:24.534] Timer tick, asking Buildbucket for the build status
[09:00:24.999] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:24.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:183:0) after 1m0s
[09:01:25.140] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:183:0)
[09:01:25.140] Timer tick, asking Buildbucket for the build status
[09:01:25.241] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:25.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:184:0) after 1m0s
[09:02:25.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:184:0)
[09:02:25.355] Timer tick, asking Buildbucket for the build status
[09:02:25.437] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:25.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:185:0) after 1m0s
[09:03:25.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:185:0)
[09:03:25.525] Timer tick, asking Buildbucket for the build status
[09:03:25.601] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:25.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:186:0) after 1m0s
[09:04:25.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:186:0)
[09:04:25.721] Timer tick, asking Buildbucket for the build status
[09:04:25.792] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:25.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:187:0) after 1m0s
[09:05:25.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:187:0)
[09:05:25.908] Timer tick, asking Buildbucket for the build status
[09:05:27.390] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:27.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:188:0) after 1m0s
[09:06:27.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:188:0)
[09:06:27.474] Timer tick, asking Buildbucket for the build status
[09:06:27.930] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:27.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:189:0) after 1m0s
[09:07:28.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:189:0)
[09:07:28.062] Timer tick, asking Buildbucket for the build status
[09:07:28.252] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:28.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:190:0) after 1m0s
[09:08:28.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:190:0)
[09:08:28.334] Timer tick, asking Buildbucket for the build status
[09:08:28.422] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:28.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:191:0) after 1m0s
[09:09:28.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:191:0)
[09:09:28.541] Timer tick, asking Buildbucket for the build status
[09:09:28.785] Build 8874007515113407744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:28.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039437577109174720:192:0) after 1m0s
[09:10:12.483] Received PubSub notification, asking Buildbucket for the build status
[09:10:12.599] Build 8874007515113407744: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:10:12.599] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1595495411546778",
    "created_by": "project:infra",
    "created_ts": "1595483971448651",
    "id": "8874007515113407744",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4209.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"485602dd-d265-4d66-bd53-dda9a4b23582\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4209.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-rh7e\"], \"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\": [\"5425-e4e3059\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1595483993992373",
    "status": "COMPLETED",
    "status_changed_ts": "1595495411995584",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9039437577109174720",
      "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/8874007515113407744/+/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:4d9312ebde969610",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1595495412078126",
    "url": "https://ci.chromium.org/b/8874007515113407744",
    "utcnow_ts": "1595495412590153"
  }
}
[09:10:12.599] Invocation finished in 3h10m42.438029911s with status SUCCEEDED