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

• parent_buildername:publish_tarball
• user_agent:recipe

[10:44:39.082] New invocation is queued and will start shortly
[10:44:39.082] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:44:40.162] Starting the invocation (attempt 1)
[10:44:40.211] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:44:40.211] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:44:40.211] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9036339340267713472",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"87.0.4245.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"466853f7-06cb-4d27-99da-38c0bef4f0e0\",\"title\":\"publish_tarball/0\"}]},\"version\":\"87.0.4245.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:9036339340267713472",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[10:44:40.639] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1598438680303296",
    "id": "8870909278321255552",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4245.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"466853f7-06cb-4d27-99da-38c0bef4f0e0\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4245.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1598438680478617",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9036339340267713472",
      "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/8870909278321255552/+/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": "1598438680478733",
    "url": "https://ci.chromium.org/b/8870909278321255552",
    "utcnow_ts": "1598438680630892"
  }
}
[10:44:40.639] Task URL: https://ci.chromium.org/b/8870909278321255552
[10:44:40.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:2:0) after 1m0s
[10:45:01.143] Received PubSub notification, asking Buildbucket for the build status
[10:45:01.419] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:40.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:2:0)
[10:45:40.696] Timer tick, asking Buildbucket for the build status
[10:45:41.098] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:41.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:4:0) after 1m0s
[10:46:41.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:4:0)
[10:46:41.186] Timer tick, asking Buildbucket for the build status
[10:46:41.410] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:41.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:5:0) after 1m0s
[10:47:41.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:5:0)
[10:47:41.435] Timer tick, asking Buildbucket for the build status
[10:47:41.793] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:41.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:6:0) after 1m0s
[10:48:41.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:6:0)
[10:48:41.821] Timer tick, asking Buildbucket for the build status
[10:48:42.042] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:42.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:7:0) after 1m0s
[10:49:42.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:7:0)
[10:49:42.065] Timer tick, asking Buildbucket for the build status
[10:49:42.125] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:42.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:8:0) after 1m0s
[10:50:42.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:8:0)
[10:50:42.191] Timer tick, asking Buildbucket for the build status
[10:50:42.346] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:42.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:9:0) after 1m0s
[10:51:42.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:9:0)
[10:51:42.366] Timer tick, asking Buildbucket for the build status
[10:51:42.444] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:42.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:10:0) after 1m0s
[10:52:42.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:10:0)
[10:52:42.470] Timer tick, asking Buildbucket for the build status
[10:52:42.545] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:42.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:11:0) after 1m0s
[10:53:42.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:11:0)
[10:53:42.600] Timer tick, asking Buildbucket for the build status
[10:53:42.978] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:42.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:12:0) after 1m0s
[10:54:43.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:12:0)
[10:54:43.011] Timer tick, asking Buildbucket for the build status
[10:54:43.301] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:43.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:13:0) after 1m0s
[10:55:43.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:13:0)
[10:55:43.336] Timer tick, asking Buildbucket for the build status
[10:55:43.625] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:43.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:14:0) after 1m0s
[10:56:43.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:14:0)
[10:56:43.688] Timer tick, asking Buildbucket for the build status
[10:56:43.891] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:43.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:15:0) after 1m0s
[10:57:43.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:15:0)
[10:57:43.940] Timer tick, asking Buildbucket for the build status
[10:57:45.696] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:45.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:16:0) after 1m0s
[10:58:45.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:16:0)
[10:58:45.721] Timer tick, asking Buildbucket for the build status
[10:58:45.947] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:45.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:17:0) after 1m0s
[10:59:45.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:17:0)
[10:59:45.972] Timer tick, asking Buildbucket for the build status
[10:59:46.089] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:46.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:18:0) after 1m0s
[11:00:46.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:18:0)
[11:00:46.201] Timer tick, asking Buildbucket for the build status
[11:00:46.414] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:46.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:19:0) after 1m0s
[11:01:46.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:19:0)
[11:01:46.510] Timer tick, asking Buildbucket for the build status
[11:01:46.585] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:46.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:20:0) after 1m0s
[11:02:46.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:20:0)
[11:02:46.677] Timer tick, asking Buildbucket for the build status
[11:02:46.843] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:46.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:21:0) after 1m0s
[11:03:46.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:21:0)
[11:03:46.881] Timer tick, asking Buildbucket for the build status
[11:03:49.058] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:49.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:22:0) after 1m0s
[11:04:49.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:22:0)
[11:04:49.135] Timer tick, asking Buildbucket for the build status
[11:04:49.240] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:49.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:23:0) after 1m0s
[11:05:49.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:23:0)
[11:05:49.366] Timer tick, asking Buildbucket for the build status
[11:05:50.001] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:50.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:24:0) after 1m0s
[11:06:50.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:24:0)
[11:06:50.096] Timer tick, asking Buildbucket for the build status
[11:06:50.733] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:50.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:25:0) after 1m0s
[11:07:50.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:25:0)
[11:07:50.768] Timer tick, asking Buildbucket for the build status
[11:07:50.870] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:50.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:26:0) after 1m0s
[11:08:50.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:26:0)
[11:08:50.905] Timer tick, asking Buildbucket for the build status
[11:08:51.083] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:51.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:27:0) after 1m0s
[11:09:51.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:27:0)
[11:09:51.109] Timer tick, asking Buildbucket for the build status
[11:09:51.256] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:51.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:28:0) after 1m0s
[11:10:51.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:28:0)
[11:10:51.335] Timer tick, asking Buildbucket for the build status
[11:10:51.512] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:51.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:29:0) after 1m0s
[11:11:51.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:29:0)
[11:11:51.588] Timer tick, asking Buildbucket for the build status
[11:11:51.658] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:51.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:30:0) after 1m0s
[11:12:51.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:30:0)
[11:12:51.672] Timer tick, asking Buildbucket for the build status
[11:12:51.739] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:51.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:31:0) after 1m0s
[11:13:51.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:31:0)
[11:13:51.880] Timer tick, asking Buildbucket for the build status
[11:13:51.941] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:51.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:32:0) after 1m0s
[11:14:52.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:32:0)
[11:14:52.044] Timer tick, asking Buildbucket for the build status
[11:14:52.363] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:52.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:33:0) after 1m0s
[11:15:52.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:33:0)
[11:15:52.450] Timer tick, asking Buildbucket for the build status
[11:15:52.615] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:52.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:34:0) after 1m0s
[11:16:52.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:34:0)
[11:16:52.754] Timer tick, asking Buildbucket for the build status
[11:16:52.838] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:52.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:35:0) after 1m0s
[11:17:52.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:35:0)
[11:17:52.902] Timer tick, asking Buildbucket for the build status
[11:17:52.982] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:52.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:36:0) after 1m0s
[11:18:53.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:36:0)
[11:18:53.076] Timer tick, asking Buildbucket for the build status
[11:18:53.172] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:53.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:37:0) after 1m0s
[11:19:53.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:37:0)
[11:19:53.293] Timer tick, asking Buildbucket for the build status
[11:19:53.383] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:53.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:38:0) after 1m0s
[11:20:53.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:38:0)
[11:20:53.455] Timer tick, asking Buildbucket for the build status
[11:20:53.531] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:53.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:39:0) after 1m0s
[11:21:53.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:39:0)
[11:21:53.558] Timer tick, asking Buildbucket for the build status
[11:21:53.625] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:53.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:40:0) after 1m0s
[11:22:53.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:40:0)
[11:22:53.681] Timer tick, asking Buildbucket for the build status
[11:22:53.910] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:53.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:41:0) after 1m0s
[11:23:54.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:41:0)
[11:23:54.007] Timer tick, asking Buildbucket for the build status
[11:23:54.077] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:54.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:42:0) after 1m0s
[11:24:54.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:42:0)
[11:24:54.109] Timer tick, asking Buildbucket for the build status
[11:24:54.418] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:54.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:43:0) after 1m0s
[11:25:54.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:43:0)
[11:25:54.470] Timer tick, asking Buildbucket for the build status
[11:25:54.544] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:54.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:44:0) after 1m0s
[11:26:54.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:44:0)
[11:26:54.577] Timer tick, asking Buildbucket for the build status
[11:26:54.673] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:54.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:45:0) after 1m0s
[11:27:54.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:45:0)
[11:27:54.703] Timer tick, asking Buildbucket for the build status
[11:27:54.793] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:54.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:46:0) after 1m0s
[11:28:54.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:46:0)
[11:28:54.798] Timer tick, asking Buildbucket for the build status
[11:28:54.903] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:54.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:47:0) after 1m0s
[11:29:54.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:47:0)
[11:29:54.931] Timer tick, asking Buildbucket for the build status
[11:29:55.055] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:55.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:48:0) after 1m0s
[11:30:55.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:48:0)
[11:30:55.334] Timer tick, asking Buildbucket for the build status
[11:30:55.394] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:55.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:49:0) after 1m0s
[11:31:55.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:49:0)
[11:31:55.427] Timer tick, asking Buildbucket for the build status
[11:31:55.605] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:55.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:50:0) after 1m0s
[11:32:55.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:50:0)
[11:32:55.605] Timer tick, asking Buildbucket for the build status
[11:32:55.897] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:55.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:51:0) after 1m0s
[11:33:56.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:51:0)
[11:33:56.027] Timer tick, asking Buildbucket for the build status
[11:33:56.198] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:56.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:52:0) after 1m0s
[11:34:56.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:52:0)
[11:34:56.232] Timer tick, asking Buildbucket for the build status
[11:34:56.382] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:56.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:53:0) after 1m0s
[11:35:56.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:53:0)
[11:35:56.377] Timer tick, asking Buildbucket for the build status
[11:35:56.613] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:56.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:54:0) after 1m0s
[11:36:56.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:54:0)
[11:36:56.686] Timer tick, asking Buildbucket for the build status
[11:36:56.891] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:56.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:55:0) after 1m0s
[11:37:56.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:55:0)
[11:37:56.912] Timer tick, asking Buildbucket for the build status
[11:37:56.978] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:56.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:56:0) after 1m0s
[11:38:57.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:56:0)
[11:38:57.039] Timer tick, asking Buildbucket for the build status
[11:38:57.234] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:57.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:57:0) after 1m0s
[11:39:57.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:57:0)
[11:39:57.238] Timer tick, asking Buildbucket for the build status
[11:39:57.339] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:57.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:58:0) after 1m0s
[11:40:57.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:58:0)
[11:40:57.379] Timer tick, asking Buildbucket for the build status
[11:40:57.877] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:57.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:59:0) after 1m0s
[11:41:57.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:59:0)
[11:41:57.939] Timer tick, asking Buildbucket for the build status
[11:41:58.005] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:58.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:60:0) after 1m0s
[11:42:58.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:60:0)
[11:42:58.060] Timer tick, asking Buildbucket for the build status
[11:42:58.344] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:58.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:61:0) after 1m0s
[11:43:58.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:61:0)
[11:43:58.414] Timer tick, asking Buildbucket for the build status
[11:43:58.477] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:58.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:62:0) after 1m0s
[11:44:58.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:62:0)
[11:44:58.508] Timer tick, asking Buildbucket for the build status
[11:44:58.645] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:58.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:63:0) after 1m0s
[11:45:58.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:63:0)
[11:45:58.755] Timer tick, asking Buildbucket for the build status
[11:45:58.907] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:58.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:64:0) after 1m0s
[11:46:58.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:64:0)
[11:46:58.941] Timer tick, asking Buildbucket for the build status
[11:46:59.092] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:59.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:65:0) after 1m0s
[11:47:59.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:65:0)
[11:47:59.116] Timer tick, asking Buildbucket for the build status
[11:47:59.173] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:59.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:66:0) after 1m0s
[11:48:59.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:66:0)
[11:48:59.249] Timer tick, asking Buildbucket for the build status
[11:48:59.318] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:59.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:67:0) after 1m0s
[11:49:59.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:67:0)
[11:49:59.441] Timer tick, asking Buildbucket for the build status
[11:49:59.547] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:59.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:68:0) after 1m0s
[11:50:59.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:68:0)
[11:50:59.601] Timer tick, asking Buildbucket for the build status
[11:50:59.943] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:59.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:69:0) after 1m0s
[11:51:59.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:69:0)
[11:51:59.999] Timer tick, asking Buildbucket for the build status
[11:52:00.164] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:00.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:70:0) after 1m0s
[11:53:00.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:70:0)
[11:53:00.228] Timer tick, asking Buildbucket for the build status
[11:53:00.433] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:00.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:71:0) after 1m0s
[11:54:00.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:71:0)
[11:54:00.545] Timer tick, asking Buildbucket for the build status
[11:54:00.613] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:00.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:72:0) after 1m0s
[11:55:01.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:72:0)
[11:55:01.525] Timer tick, asking Buildbucket for the build status
[11:55:01.835] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:01.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:73:0) after 1m0s
[11:56:01.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:73:0)
[11:56:01.910] Timer tick, asking Buildbucket for the build status
[11:56:02.028] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:02.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:74:0) after 1m0s
[11:57:04.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:74:0)
[11:57:04.205] Timer tick, asking Buildbucket for the build status
[11:57:04.274] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:04.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:75:0) after 1m0s
[11:58:04.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:75:0)
[11:58:04.721] Timer tick, asking Buildbucket for the build status
[11:58:04.812] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:04.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:76:0) after 1m0s
[11:59:04.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:76:0)
[11:59:04.896] Timer tick, asking Buildbucket for the build status
[11:59:04.985] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:04.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:77:0) after 1m0s
[12:00:04.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:77:0)
[12:00:04.998] Timer tick, asking Buildbucket for the build status
[12:00:05.187] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:05.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:78:0) after 1m0s
[12:01:05.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:78:0)
[12:01:05.279] Timer tick, asking Buildbucket for the build status
[12:01:05.399] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:05.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:79:0) after 1m0s
[12:02:05.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:79:0)
[12:02:05.555] Timer tick, asking Buildbucket for the build status
[12:02:05.677] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:05.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:80:0) after 1m0s
[12:03:05.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:80:0)
[12:03:05.710] Timer tick, asking Buildbucket for the build status
[12:03:05.867] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:05.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:81:0) after 1m0s
[12:04:06.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:81:0)
[12:04:06.311] Timer tick, asking Buildbucket for the build status
[12:04:06.396] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:06.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:82:0) after 1m0s
[12:05:06.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:82:0)
[12:05:06.534] Timer tick, asking Buildbucket for the build status
[12:05:06.669] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:06.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:83:0) after 1m0s
[12:06:06.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:83:0)
[12:06:06.694] Timer tick, asking Buildbucket for the build status
[12:06:06.754] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:06.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:84:0) after 1m0s
[12:07:06.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:84:0)
[12:07:06.760] Timer tick, asking Buildbucket for the build status
[12:07:06.877] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:06.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:85:0) after 1m0s
[12:08:06.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:85:0)
[12:08:06.906] Timer tick, asking Buildbucket for the build status
[12:08:07.271] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:07.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:86:0) after 1m0s
[12:09:07.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:86:0)
[12:09:07.300] Timer tick, asking Buildbucket for the build status
[12:09:07.387] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:07.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:87:0) after 1m0s
[12:10:07.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:87:0)
[12:10:07.470] Timer tick, asking Buildbucket for the build status
[12:10:07.576] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:07.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:88:0) after 1m0s
[12:11:07.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:88:0)
[12:11:07.567] Timer tick, asking Buildbucket for the build status
[12:11:07.634] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:07.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:89:0) after 1m0s
[12:12:07.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:89:0)
[12:12:07.695] Timer tick, asking Buildbucket for the build status
[12:12:07.754] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:07.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:90:0) after 1m0s
[12:13:07.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:90:0)
[12:13:07.825] Timer tick, asking Buildbucket for the build status
[12:13:07.971] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:07.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:91:0) after 1m0s
[12:14:08.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:91:0)
[12:14:08.028] Timer tick, asking Buildbucket for the build status
[12:14:08.177] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:08.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:92:0) after 1m0s
[12:15:08.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:92:0)
[12:15:08.283] Timer tick, asking Buildbucket for the build status
[12:15:08.400] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:08.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:93:0) after 1m0s
[12:16:08.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:93:0)
[12:16:08.405] Timer tick, asking Buildbucket for the build status
[12:16:08.493] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:08.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:94:0) after 1m0s
[12:17:08.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:94:0)
[12:17:08.531] Timer tick, asking Buildbucket for the build status
[12:17:08.707] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:08.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:95:0) after 1m0s
[12:18:08.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:95:0)
[12:18:08.763] Timer tick, asking Buildbucket for the build status
[12:18:08.982] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:08.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:96:0) after 1m0s
[12:19:09.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:96:0)
[12:19:09.022] Timer tick, asking Buildbucket for the build status
[12:19:09.304] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:09.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:97:0) after 1m0s
[12:20:09.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:97:0)
[12:20:09.331] Timer tick, asking Buildbucket for the build status
[12:20:11.321] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:11.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:98:0) after 1m0s
[12:21:11.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:98:0)
[12:21:11.528] Timer tick, asking Buildbucket for the build status
[12:21:11.635] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:11.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:99:0) after 1m0s
[12:22:11.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:99:0)
[12:22:11.682] Timer tick, asking Buildbucket for the build status
[12:22:11.978] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:11.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:100:0) after 1m0s
[12:23:12.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:100:0)
[12:23:12.018] Timer tick, asking Buildbucket for the build status
[12:23:12.286] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:12.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:101:0) after 1m0s
[12:24:12.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:101:0)
[12:24:12.739] Timer tick, asking Buildbucket for the build status
[12:24:12.810] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:12.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:102:0) after 1m0s
[12:25:12.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:102:0)
[12:25:12.876] Timer tick, asking Buildbucket for the build status
[12:25:13.147] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:13.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:103:0) after 1m0s
[12:26:13.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:103:0)
[12:26:13.212] Timer tick, asking Buildbucket for the build status
[12:26:13.268] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:13.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:104:0) after 1m0s
[12:27:13.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:104:0)
[12:27:13.345] Timer tick, asking Buildbucket for the build status
[12:27:13.424] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:13.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:105:0) after 1m0s
[12:28:13.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:105:0)
[12:28:13.425] Timer tick, asking Buildbucket for the build status
[12:28:13.495] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:13.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:106:0) after 1m0s
[12:29:13.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:106:0)
[12:29:13.530] Timer tick, asking Buildbucket for the build status
[12:29:13.590] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:13.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:107:0) after 1m0s
[12:30:13.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:107:0)
[12:30:13.622] Timer tick, asking Buildbucket for the build status
[12:30:13.832] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:13.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:108:0) after 1m0s
[12:31:13.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:108:0)
[12:31:13.895] Timer tick, asking Buildbucket for the build status
[12:31:13.962] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:13.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:109:0) after 1m0s
[12:32:13.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:109:0)
[12:32:13.991] Timer tick, asking Buildbucket for the build status
[12:32:14.056] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:14.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:110:0) after 1m0s
[12:33:14.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:110:0)
[12:33:14.076] Timer tick, asking Buildbucket for the build status
[12:33:14.149] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:14.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:111:0) after 1m0s
[12:34:14.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:111:0)
[12:34:14.177] Timer tick, asking Buildbucket for the build status
[12:34:14.263] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:14.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:112:0) after 1m0s
[12:35:14.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:112:0)
[12:35:14.287] Timer tick, asking Buildbucket for the build status
[12:35:14.406] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:14.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:113:0) after 1m0s
[12:36:14.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:113:0)
[12:36:14.432] Timer tick, asking Buildbucket for the build status
[12:36:14.500] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:14.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:114:0) after 1m0s
[12:37:14.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:114:0)
[12:37:14.658] Timer tick, asking Buildbucket for the build status
[12:37:14.725] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:14.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:115:0) after 1m0s
[12:38:14.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:115:0)
[12:38:14.797] Timer tick, asking Buildbucket for the build status
[12:38:14.892] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:14.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:116:0) after 1m0s
[12:39:14.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:116:0)
[12:39:14.974] Timer tick, asking Buildbucket for the build status
[12:39:15.027] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:15.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:117:0) after 1m0s
[12:40:15.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:117:0)
[12:40:15.129] Timer tick, asking Buildbucket for the build status
[12:40:15.333] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:15.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:118:0) after 1m0s
[12:41:15.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:118:0)
[12:41:15.375] Timer tick, asking Buildbucket for the build status
[12:41:15.533] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:15.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:119:0) after 1m0s
[12:42:15.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:119:0)
[12:42:15.569] Timer tick, asking Buildbucket for the build status
[12:42:15.632] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:15.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:120:0) after 1m0s
[12:43:15.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:120:0)
[12:43:15.657] Timer tick, asking Buildbucket for the build status
[12:43:15.820] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:15.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:121:0) after 1m0s
[12:44:15.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:121:0)
[12:44:15.863] Timer tick, asking Buildbucket for the build status
[12:44:15.935] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:15.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:122:0) after 1m0s
[12:45:15.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:122:0)
[12:45:15.982] Timer tick, asking Buildbucket for the build status
[12:45:16.138] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:16.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:123:0) after 1m0s
[12:46:16.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:123:0)
[12:46:16.230] Timer tick, asking Buildbucket for the build status
[12:46:16.284] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:16.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:124:0) after 1m0s
[12:47:16.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:124:0)
[12:47:16.432] Timer tick, asking Buildbucket for the build status
[12:47:16.509] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:16.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:125:0) after 1m0s
[12:48:16.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:125:0)
[12:48:16.567] Timer tick, asking Buildbucket for the build status
[12:48:16.705] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:16.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:126:0) after 1m0s
[12:49:16.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:126:0)
[12:49:16.739] Timer tick, asking Buildbucket for the build status
[12:49:16.791] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:16.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:127:0) after 1m0s
[12:50:16.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:127:0)
[12:50:16.859] Timer tick, asking Buildbucket for the build status
[12:50:16.976] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:16.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:128:0) after 1m0s
[12:51:17.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:128:0)
[12:51:17.066] Timer tick, asking Buildbucket for the build status
[12:51:17.143] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:17.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:129:0) after 1m0s
[12:52:17.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:129:0)
[12:52:17.211] Timer tick, asking Buildbucket for the build status
[12:52:17.270] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:17.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:130:0) after 1m0s
[12:53:17.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:130:0)
[12:53:17.330] Timer tick, asking Buildbucket for the build status
[12:53:17.617] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:17.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:131:0) after 1m0s
[12:54:17.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:131:0)
[12:54:17.747] Timer tick, asking Buildbucket for the build status
[12:54:17.816] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:17.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:132:0) after 1m0s
[12:55:18.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:132:0)
[12:55:18.026] Timer tick, asking Buildbucket for the build status
[12:55:18.501] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:18.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:133:0) after 1m0s
[12:56:18.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:133:0)
[12:56:18.547] Timer tick, asking Buildbucket for the build status
[12:56:18.905] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:18.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:134:0) after 1m0s
[12:57:18.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:134:0)
[12:57:18.931] Timer tick, asking Buildbucket for the build status
[12:57:20.638] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:20.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:135:0) after 1m0s
[12:58:20.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:135:0)
[12:58:20.681] Timer tick, asking Buildbucket for the build status
[12:58:20.877] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:20.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:136:0) after 1m0s
[12:59:20.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:136:0)
[12:59:20.923] Timer tick, asking Buildbucket for the build status
[12:59:21.202] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:21.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:137:0) after 1m0s
[13:00:21.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:137:0)
[13:00:21.334] Timer tick, asking Buildbucket for the build status
[13:00:21.633] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:21.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:138:0) after 1m0s
[13:01:21.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:138:0)
[13:01:21.721] Timer tick, asking Buildbucket for the build status
[13:01:21.882] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:21.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:139:0) after 1m0s
[13:02:21.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:139:0)
[13:02:21.922] Timer tick, asking Buildbucket for the build status
[13:02:21.987] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:21.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:140:0) after 1m0s
[13:03:22.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:140:0)
[13:03:22.025] Timer tick, asking Buildbucket for the build status
[13:03:22.169] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:22.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:141:0) after 1m0s
[13:04:22.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:141:0)
[13:04:22.235] Timer tick, asking Buildbucket for the build status
[13:04:22.294] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:22.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:142:0) after 1m0s
[13:05:22.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:142:0)
[13:05:22.382] Timer tick, asking Buildbucket for the build status
[13:05:22.492] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:22.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:143:0) after 1m0s
[13:06:22.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:143:0)
[13:06:22.746] Timer tick, asking Buildbucket for the build status
[13:06:22.995] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:22.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:144:0) after 1m0s
[13:07:23.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:144:0)
[13:07:23.157] Timer tick, asking Buildbucket for the build status
[13:07:23.232] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:23.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:145:0) after 1m0s
[13:08:23.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:145:0)
[13:08:23.328] Timer tick, asking Buildbucket for the build status
[13:08:23.388] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:23.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:146:0) after 1m0s
[13:09:23.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:146:0)
[13:09:23.586] Timer tick, asking Buildbucket for the build status
[13:09:23.660] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:23.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:147:0) after 1m0s
[13:10:23.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:147:0)
[13:10:23.806] Timer tick, asking Buildbucket for the build status
[13:10:24.005] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:24.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:148:0) after 1m0s
[13:11:24.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:148:0)
[13:11:24.103] Timer tick, asking Buildbucket for the build status
[13:11:24.211] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:24.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:149:0) after 1m0s
[13:12:24.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:149:0)
[13:12:24.385] Timer tick, asking Buildbucket for the build status
[13:12:24.475] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:24.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:150:0) after 1m0s
[13:13:24.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:150:0)
[13:13:24.674] Timer tick, asking Buildbucket for the build status
[13:13:24.814] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:24.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:151:0) after 1m0s
[13:14:25.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:151:0)
[13:14:25.022] Timer tick, asking Buildbucket for the build status
[13:14:25.090] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:25.090] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:152:0) after 1m0s
[13:15:25.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:152:0)
[13:15:25.635] Timer tick, asking Buildbucket for the build status
[13:15:26.012] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:26.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:153:0) after 1m0s
[13:16:26.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:153:0)
[13:16:26.033] Timer tick, asking Buildbucket for the build status
[13:16:26.128] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:26.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:154:0) after 1m0s
[13:17:26.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:154:0)
[13:17:26.378] Timer tick, asking Buildbucket for the build status
[13:17:26.510] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:26.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:155:0) after 1m0s
[13:18:26.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:155:0)
[13:18:26.578] Timer tick, asking Buildbucket for the build status
[13:18:26.643] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:26.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:156:0) after 1m0s
[13:19:26.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:156:0)
[13:19:26.757] Timer tick, asking Buildbucket for the build status
[13:19:26.836] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:26.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:157:0) after 1m0s
[13:20:27.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:157:0)
[13:20:27.085] Timer tick, asking Buildbucket for the build status
[13:20:27.204] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:27.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:158:0) after 1m0s
[13:21:27.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:158:0)
[13:21:27.402] Timer tick, asking Buildbucket for the build status
[13:21:27.500] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:27.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:159:0) after 1m0s
[13:22:27.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:159:0)
[13:22:27.681] Timer tick, asking Buildbucket for the build status
[13:22:27.762] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:27.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:160:0) after 1m0s
[13:23:28.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:160:0)
[13:23:28.500] Timer tick, asking Buildbucket for the build status
[13:23:28.622] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:28.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:161:0) after 1m0s
[13:24:29.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:161:0)
[13:24:29.013] Timer tick, asking Buildbucket for the build status
[13:24:29.187] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:29.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:162:0) after 1m0s
[13:25:29.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:162:0)
[13:25:29.362] Timer tick, asking Buildbucket for the build status
[13:25:29.654] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:29.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:163:0) after 1m0s
[13:26:29.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:163:0)
[13:26:29.822] Timer tick, asking Buildbucket for the build status
[13:26:29.923] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:29.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:164:0) after 1m0s
[13:27:29.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:164:0)
[13:27:29.962] Timer tick, asking Buildbucket for the build status
[13:27:30.114] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:30.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:165:0) after 1m0s
[13:28:30.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:165:0)
[13:28:30.205] Timer tick, asking Buildbucket for the build status
[13:28:30.398] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:30.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:166:0) after 1m0s
[13:29:30.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:166:0)
[13:29:30.577] Timer tick, asking Buildbucket for the build status
[13:29:30.883] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:30.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:167:0) after 1m0s
[13:30:31.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:167:0)
[13:30:31.195] Timer tick, asking Buildbucket for the build status
[13:30:31.337] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:31.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:168:0) after 1m0s
[13:31:31.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:168:0)
[13:31:31.400] Timer tick, asking Buildbucket for the build status
[13:31:31.476] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:31.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:169:0) after 1m0s
[13:32:31.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:169:0)
[13:32:31.520] Timer tick, asking Buildbucket for the build status
[13:32:31.750] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:31.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:170:0) after 1m0s
[13:33:31.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:170:0)
[13:33:31.793] Timer tick, asking Buildbucket for the build status
[13:33:32.054] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:32.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:171:0) after 1m0s
[13:34:32.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:171:0)
[13:34:32.129] Timer tick, asking Buildbucket for the build status
[13:34:32.209] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:32.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:172:0) after 1m0s
[13:35:32.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:172:0)
[13:35:32.411] Timer tick, asking Buildbucket for the build status
[13:35:32.509] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:32.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:173:0) after 1m0s
[13:36:32.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:173:0)
[13:36:32.583] Timer tick, asking Buildbucket for the build status
[13:36:32.833] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:32.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:174:0) after 1m0s
[13:37:32.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:174:0)
[13:37:32.870] Timer tick, asking Buildbucket for the build status
[13:37:32.955] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:32.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:175:0) after 1m0s
[13:38:32.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:175:0)
[13:38:32.993] Timer tick, asking Buildbucket for the build status
[13:38:33.088] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:33.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:176:0) after 1m0s
[13:39:33.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:176:0)
[13:39:33.154] Timer tick, asking Buildbucket for the build status
[13:39:33.339] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:33.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:177:0) after 1m0s
[13:40:33.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:177:0)
[13:40:33.364] Timer tick, asking Buildbucket for the build status
[13:40:33.781] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:33.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:178:0) after 1m0s
[13:41:34.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:178:0)
[13:41:34.103] Timer tick, asking Buildbucket for the build status
[13:41:34.166] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:34.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:179:0) after 1m0s
[13:42:34.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:179:0)
[13:42:34.280] Timer tick, asking Buildbucket for the build status
[13:42:34.368] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:34.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:180:0) after 1m0s
[13:43:34.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:180:0)
[13:43:34.614] Timer tick, asking Buildbucket for the build status
[13:43:35.869] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:35.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:181:0) after 1m0s
[13:44:36.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:181:0)
[13:44:36.146] Timer tick, asking Buildbucket for the build status
[13:44:36.261] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:36.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:182:0) after 1m0s
[13:45:36.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:182:0)
[13:45:36.716] Timer tick, asking Buildbucket for the build status
[13:45:37.036] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:37.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:183:0) after 1m0s
[13:46:37.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:183:0)
[13:46:37.699] Timer tick, asking Buildbucket for the build status
[13:46:37.755] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:37.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:184:0) after 1m0s
[13:47:38.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:184:0)
[13:47:38.068] Timer tick, asking Buildbucket for the build status
[13:47:38.130] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:38.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:185:0) after 1m0s
[13:48:38.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:185:0)
[13:48:38.700] Timer tick, asking Buildbucket for the build status
[13:48:38.760] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:38.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:186:0) after 1m0s
[13:49:38.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:186:0)
[13:49:38.862] Timer tick, asking Buildbucket for the build status
[13:49:38.966] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:38.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:187:0) after 1m0s
[13:50:39.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:187:0)
[13:50:39.191] Timer tick, asking Buildbucket for the build status
[13:50:39.421] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:39.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:188:0) after 1m0s
[13:51:39.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:188:0)
[13:51:39.612] Timer tick, asking Buildbucket for the build status
[13:51:39.694] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:39.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:189:0) after 1m0s
[13:52:39.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:189:0)
[13:52:39.788] Timer tick, asking Buildbucket for the build status
[13:52:39.901] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:39.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:190:0) after 1m0s
[13:53:39.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:190:0)
[13:53:39.963] Timer tick, asking Buildbucket for the build status
[13:53:40.183] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:40.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:191:0) after 1m0s
[13:54:40.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:191:0)
[13:54:40.346] Timer tick, asking Buildbucket for the build status
[13:54:40.515] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:40.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:192:0) after 1m0s
[13:55:40.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:192:0)
[13:55:40.547] Timer tick, asking Buildbucket for the build status
[13:55:40.904] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:40.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:193:0) after 1m0s
[13:56:41.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:193:0)
[13:56:41.003] Timer tick, asking Buildbucket for the build status
[13:56:41.065] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:41.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:194:0) after 1m0s
[13:57:41.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:194:0)
[13:57:41.049] Timer tick, asking Buildbucket for the build status
[13:57:41.125] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:41.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:195:0) after 1m0s
[13:58:41.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:195:0)
[13:58:41.285] Timer tick, asking Buildbucket for the build status
[13:58:41.348] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:41.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:196:0) after 1m0s
[13:59:41.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:196:0)
[13:59:41.405] Timer tick, asking Buildbucket for the build status
[13:59:41.566] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:41.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:197:0) after 1m0s
[14:00:41.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:197:0)
[14:00:41.743] Timer tick, asking Buildbucket for the build status
[14:00:42.158] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:42.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:198:0) after 1m0s
[14:01:42.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:198:0)
[14:01:42.992] Timer tick, asking Buildbucket for the build status
[14:01:43.065] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:43.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:199:0) after 1m0s
[14:02:43.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:199:0)
[14:02:43.431] Timer tick, asking Buildbucket for the build status
[14:02:43.603] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:43.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:200:0) after 1m0s
[14:03:43.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:200:0)
[14:03:43.737] Timer tick, asking Buildbucket for the build status
[14:03:43.818] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:43.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:201:0) after 1m0s
[14:04:44.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:201:0)
[14:04:44.399] Timer tick, asking Buildbucket for the build status
[14:04:44.466] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:44.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:202:0) after 1m0s
[14:05:44.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:202:0)
[14:05:44.567] Timer tick, asking Buildbucket for the build status
[14:05:44.736] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:44.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:203:0) after 1m0s
[14:06:44.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:203:0)
[14:06:44.806] Timer tick, asking Buildbucket for the build status
[14:06:44.924] Build 8870909278321255552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:44.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036339340267713472:204:0) after 1m0s
[14:07:05.977] Received PubSub notification, asking Buildbucket for the build status
[14:07:06.038] Build 8870909278321255552: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:07:06.038] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1598450825110385",
    "created_by": "project:infra",
    "created_ts": "1598438680303296",
    "id": "8870909278321255552",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4245.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"466853f7-06cb-4d27-99da-38c0bef4f0e0\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4245.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-o3v8\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"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\": [\"5498-3454aa6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1598438700403832",
    "status": "COMPLETED",
    "status_changed_ts": "1598450825481390",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9036339340267713472",
      "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/8870909278321255552/+/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:4e433031cfa61510",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1598450825496817",
    "url": "https://ci.chromium.org/b/8870909278321255552",
    "utcnow_ts": "1598450826030391"
  }
}
[14:07:06.038] Invocation finished in 3h22m26.974260733s with status SUCCEEDED