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

• parent_buildername:publish_tarball
• user_agent:recipe

[07:42:14.987] New invocation is queued and will start shortly
[07:42:14.987] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[07:42:16.818] Starting the invocation (attempt 1)
[07:42:16.868] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:42:16.869] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:42:16.869] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9038162755308623200",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4225.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"523af7cc-3692-41ad-bee8-2aa788fd8038\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4225.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:9038162755308623200",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[07:42:17.595] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1596699737003606",
    "id": "8872732692530632416",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4225.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"523af7cc-3692-41ad-bee8-2aa788fd8038\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4225.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1596699737330430",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038162755308623200",
      "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/8872732692530632416/+/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": "1596699737330589",
    "url": "https://ci.chromium.org/b/8872732692530632416",
    "utcnow_ts": "1596699737583704"
  }
}
[07:42:17.595] Task URL: https://ci.chromium.org/b/8872732692530632416
[07:42:17.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:2:0) after 1m0s
[07:43:15.235] Received PubSub notification, asking Buildbucket for the build status
[07:43:15.397] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:17.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:2:0)
[07:43:17.653] Timer tick, asking Buildbucket for the build status
[07:43:17.746] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:17.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:4:0) after 1m0s
[07:44:18.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:4:0)
[07:44:18.009] Timer tick, asking Buildbucket for the build status
[07:44:18.156] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:18.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:5:0) after 1m0s
[07:45:18.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:5:0)
[07:45:18.299] Timer tick, asking Buildbucket for the build status
[07:45:18.455] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:18.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:6:0) after 1m0s
[07:46:18.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:6:0)
[07:46:18.490] Timer tick, asking Buildbucket for the build status
[07:46:20.245] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:20.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:7:0) after 1m0s
[07:47:20.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:7:0)
[07:47:20.390] Timer tick, asking Buildbucket for the build status
[07:47:20.665] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:20.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:8:0) after 1m0s
[07:48:20.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:8:0)
[07:48:20.716] Timer tick, asking Buildbucket for the build status
[07:48:20.833] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:20.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:9:0) after 1m0s
[07:49:20.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:9:0)
[07:49:20.928] Timer tick, asking Buildbucket for the build status
[07:49:21.180] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:21.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:10:0) after 1m0s
[07:50:21.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:10:0)
[07:50:21.357] Timer tick, asking Buildbucket for the build status
[07:50:21.514] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:21.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:11:0) after 1m0s
[07:51:21.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:11:0)
[07:51:21.569] Timer tick, asking Buildbucket for the build status
[07:51:21.651] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:21.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:12:0) after 1m0s
[07:52:21.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:12:0)
[07:52:21.679] Timer tick, asking Buildbucket for the build status
[07:52:21.861] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:21.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:13:0) after 1m0s
[07:53:21.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:13:0)
[07:53:21.887] Timer tick, asking Buildbucket for the build status
[07:53:22.129] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:22.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:14:0) after 1m0s
[07:54:22.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:14:0)
[07:54:22.172] Timer tick, asking Buildbucket for the build status
[07:54:22.335] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:22.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:15:0) after 1m0s
[07:55:22.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:15:0)
[07:55:22.358] Timer tick, asking Buildbucket for the build status
[07:55:22.499] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:22.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:16:0) after 1m0s
[07:56:22.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:16:0)
[07:56:22.529] Timer tick, asking Buildbucket for the build status
[07:56:22.621] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:22.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:17:0) after 1m0s
[07:57:22.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:17:0)
[07:57:22.692] Timer tick, asking Buildbucket for the build status
[07:57:22.834] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:22.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:18:0) after 1m0s
[07:58:22.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:18:0)
[07:58:22.951] Timer tick, asking Buildbucket for the build status
[07:58:23.034] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:23.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:19:0) after 1m0s
[07:59:23.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:19:0)
[07:59:23.153] Timer tick, asking Buildbucket for the build status
[07:59:23.434] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:23.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:20:0) after 1m0s
[08:00:23.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:20:0)
[08:00:23.492] Timer tick, asking Buildbucket for the build status
[08:00:23.756] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:23.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:21:0) after 1m0s
[08:01:23.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:21:0)
[08:01:23.812] Timer tick, asking Buildbucket for the build status
[08:01:23.910] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:23.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:22:0) after 1m0s
[08:02:23.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:22:0)
[08:02:23.915] Timer tick, asking Buildbucket for the build status
[08:02:24.067] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:24.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:23:0) after 1m0s
[08:03:24.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:23:0)
[08:03:24.064] Timer tick, asking Buildbucket for the build status
[08:03:24.565] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:24.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:24:0) after 1m0s
[08:04:24.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:24:0)
[08:04:24.590] Timer tick, asking Buildbucket for the build status
[08:04:24.842] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:24.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:25:0) after 1m0s
[08:05:24.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:25:0)
[08:05:24.879] Timer tick, asking Buildbucket for the build status
[08:05:24.949] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:24.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:26:0) after 1m0s
[08:06:25.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:26:0)
[08:06:25.012] Timer tick, asking Buildbucket for the build status
[08:06:25.210] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:25.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:27:0) after 1m0s
[08:07:25.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:27:0)
[08:07:25.283] Timer tick, asking Buildbucket for the build status
[08:07:25.515] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:25.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:28:0) after 1m0s
[08:08:25.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:28:0)
[08:08:25.534] Timer tick, asking Buildbucket for the build status
[08:08:25.618] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:25.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:29:0) after 1m0s
[08:09:25.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:29:0)
[08:09:25.720] Timer tick, asking Buildbucket for the build status
[08:09:25.775] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:25.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:30:0) after 1m0s
[08:10:25.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:30:0)
[08:10:25.753] Timer tick, asking Buildbucket for the build status
[08:10:25.829] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:25.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:31:0) after 1m0s
[08:11:25.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:31:0)
[08:11:25.871] Timer tick, asking Buildbucket for the build status
[08:11:25.950] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:25.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:32:0) after 1m0s
[08:12:26.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:32:0)
[08:12:26.004] Timer tick, asking Buildbucket for the build status
[08:12:26.319] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:26.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:33:0) after 1m0s
[08:13:26.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:33:0)
[08:13:26.348] Timer tick, asking Buildbucket for the build status
[08:13:26.465] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:26.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:34:0) after 1m0s
[08:14:26.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:34:0)
[08:14:26.498] Timer tick, asking Buildbucket for the build status
[08:14:26.616] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:26.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:35:0) after 1m0s
[08:15:26.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:35:0)
[08:15:26.673] Timer tick, asking Buildbucket for the build status
[08:15:26.754] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:26.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:36:0) after 1m0s
[08:16:26.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:36:0)
[08:16:26.729] Timer tick, asking Buildbucket for the build status
[08:16:26.817] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:26.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:37:0) after 1m0s
[08:17:26.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:37:0)
[08:17:26.940] Timer tick, asking Buildbucket for the build status
[08:17:27.171] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:27.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:38:0) after 1m0s
[08:18:27.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:38:0)
[08:18:27.258] Timer tick, asking Buildbucket for the build status
[08:18:27.321] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:27.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:39:0) after 1m0s
[08:19:27.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:39:0)
[08:19:27.470] Timer tick, asking Buildbucket for the build status
[08:19:27.536] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:27.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:40:0) after 1m0s
[08:20:27.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:40:0)
[08:20:27.557] Timer tick, asking Buildbucket for the build status
[08:20:27.613] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:27.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:41:0) after 1m0s
[08:21:27.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:41:0)
[08:21:27.670] Timer tick, asking Buildbucket for the build status
[08:21:27.755] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:27.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:42:0) after 1m0s
[08:22:27.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:42:0)
[08:22:27.890] Timer tick, asking Buildbucket for the build status
[08:22:28.004] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:28.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:43:0) after 1m0s
[08:23:28.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:43:0)
[08:23:28.128] Timer tick, asking Buildbucket for the build status
[08:23:28.307] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:28.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:44:0) after 1m0s
[08:24:28.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:44:0)
[08:24:28.447] Timer tick, asking Buildbucket for the build status
[08:24:28.624] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:28.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:45:0) after 1m0s
[08:25:28.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:45:0)
[08:25:28.751] Timer tick, asking Buildbucket for the build status
[08:25:28.977] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:28.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:46:0) after 1m0s
[08:26:28.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:46:0)
[08:26:28.996] Timer tick, asking Buildbucket for the build status
[08:26:29.077] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:29.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:47:0) after 1m0s
[08:27:29.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:47:0)
[08:27:29.237] Timer tick, asking Buildbucket for the build status
[08:27:29.356] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:29.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:48:0) after 1m0s
[08:28:29.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:48:0)
[08:28:29.380] Timer tick, asking Buildbucket for the build status
[08:28:29.608] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:29.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:49:0) after 1m0s
[08:29:29.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:49:0)
[08:29:29.634] Timer tick, asking Buildbucket for the build status
[08:29:29.847] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:29.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:50:0) after 1m0s
[08:30:30.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:50:0)
[08:30:30.241] Timer tick, asking Buildbucket for the build status
[08:30:30.308] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:30.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:51:0) after 1m0s
[08:31:30.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:51:0)
[08:31:30.443] Timer tick, asking Buildbucket for the build status
[08:31:30.558] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:30.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:52:0) after 1m0s
[08:32:30.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:52:0)
[08:32:30.682] Timer tick, asking Buildbucket for the build status
[08:32:30.825] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:30.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:53:0) after 1m0s
[08:33:31.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:53:0)
[08:33:31.098] Timer tick, asking Buildbucket for the build status
[08:33:32.642] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:32.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:54:0) after 1m0s
[08:34:32.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:54:0)
[08:34:32.820] Timer tick, asking Buildbucket for the build status
[08:34:32.902] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:32.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:55:0) after 1m0s
[08:35:32.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:55:0)
[08:35:32.938] Timer tick, asking Buildbucket for the build status
[08:35:33.250] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:33.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:56:0) after 1m0s
[08:36:33.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:56:0)
[08:36:33.597] Timer tick, asking Buildbucket for the build status
[08:36:33.664] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:33.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:57:0) after 1m0s
[08:37:33.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:57:0)
[08:37:33.879] Timer tick, asking Buildbucket for the build status
[08:37:34.198] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:34.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:58:0) after 1m0s
[08:38:34.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:58:0)
[08:38:34.291] Timer tick, asking Buildbucket for the build status
[08:38:34.575] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:34.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:59:0) after 1m0s
[08:39:34.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:59:0)
[08:39:34.753] Timer tick, asking Buildbucket for the build status
[08:39:34.844] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:34.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:60:0) after 1m0s
[08:40:34.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:60:0)
[08:40:34.903] Timer tick, asking Buildbucket for the build status
[08:40:34.976] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:34.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:61:0) after 1m0s
[08:41:35.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:61:0)
[08:41:35.005] Timer tick, asking Buildbucket for the build status
[08:41:35.121] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:35.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:62:0) after 1m0s
[08:42:35.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:62:0)
[08:42:35.108] Timer tick, asking Buildbucket for the build status
[08:42:35.461] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:35.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:63:0) after 1m0s
[08:43:35.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:63:0)
[08:43:35.533] Timer tick, asking Buildbucket for the build status
[08:43:35.607] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:35.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:64:0) after 1m0s
[08:44:35.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:64:0)
[08:44:35.776] Timer tick, asking Buildbucket for the build status
[08:44:35.916] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:35.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:65:0) after 1m0s
[08:45:35.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:65:0)
[08:45:35.998] Timer tick, asking Buildbucket for the build status
[08:45:36.105] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:36.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:66:0) after 1m0s
[08:46:36.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:66:0)
[08:46:36.137] Timer tick, asking Buildbucket for the build status
[08:46:36.317] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:36.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:67:0) after 1m0s
[08:47:36.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:67:0)
[08:47:36.441] Timer tick, asking Buildbucket for the build status
[08:47:36.651] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:36.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:68:0) after 1m0s
[08:48:36.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:68:0)
[08:48:36.804] Timer tick, asking Buildbucket for the build status
[08:48:36.883] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:36.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:69:0) after 1m0s
[08:49:37.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:69:0)
[08:49:37.068] Timer tick, asking Buildbucket for the build status
[08:49:37.146] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:37.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:70:0) after 1m0s
[08:50:37.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:70:0)
[08:50:37.237] Timer tick, asking Buildbucket for the build status
[08:50:37.613] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:37.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:71:0) after 1m0s
[08:51:37.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:71:0)
[08:51:37.627] Timer tick, asking Buildbucket for the build status
[08:51:38.091] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:38.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:72:0) after 1m0s
[08:52:38.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:72:0)
[08:52:38.224] Timer tick, asking Buildbucket for the build status
[08:52:38.337] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:38.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:73:0) after 1m0s
[08:53:38.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:73:0)
[08:53:38.472] Timer tick, asking Buildbucket for the build status
[08:53:38.733] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:38.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:74:0) after 1m0s
[08:54:38.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:74:0)
[08:54:38.830] Timer tick, asking Buildbucket for the build status
[08:54:39.193] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:39.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:75:0) after 1m0s
[08:55:39.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:75:0)
[08:55:39.271] Timer tick, asking Buildbucket for the build status
[08:55:39.442] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:39.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:76:0) after 1m0s
[08:56:39.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:76:0)
[08:56:39.532] Timer tick, asking Buildbucket for the build status
[08:56:39.621] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:39.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:77:0) after 1m0s
[08:57:39.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:77:0)
[08:57:39.678] Timer tick, asking Buildbucket for the build status
[08:57:39.989] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:39.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:78:0) after 1m0s
[08:58:40.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:78:0)
[08:58:40.089] Timer tick, asking Buildbucket for the build status
[08:58:40.170] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:40.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:79:0) after 1m0s
[08:59:40.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:79:0)
[08:59:40.262] Timer tick, asking Buildbucket for the build status
[08:59:40.389] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:40.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:80:0) after 1m0s
[09:00:40.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:80:0)
[09:00:40.482] Timer tick, asking Buildbucket for the build status
[09:00:40.953] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:40.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:81:0) after 1m0s
[09:01:41.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:81:0)
[09:01:41.051] Timer tick, asking Buildbucket for the build status
[09:01:41.298] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:41.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:82:0) after 1m0s
[09:02:41.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:82:0)
[09:02:41.348] Timer tick, asking Buildbucket for the build status
[09:02:41.520] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:41.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:83:0) after 1m0s
[09:03:41.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:83:0)
[09:03:41.636] Timer tick, asking Buildbucket for the build status
[09:03:41.805] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:41.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:84:0) after 1m0s
[09:04:41.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:84:0)
[09:04:41.899] Timer tick, asking Buildbucket for the build status
[09:04:42.254] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:42.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:85:0) after 1m0s
[09:05:42.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:85:0)
[09:05:42.323] Timer tick, asking Buildbucket for the build status
[09:05:42.401] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:42.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:86:0) after 1m0s
[09:06:42.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:86:0)
[09:06:42.474] Timer tick, asking Buildbucket for the build status
[09:06:42.549] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:42.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:87:0) after 1m0s
[09:07:42.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:87:0)
[09:07:42.627] Timer tick, asking Buildbucket for the build status
[09:07:42.839] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:42.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:88:0) after 1m0s
[09:08:42.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:88:0)
[09:08:42.830] Timer tick, asking Buildbucket for the build status
[09:08:42.950] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:42.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:89:0) after 1m0s
[09:09:42.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:89:0)
[09:09:42.982] Timer tick, asking Buildbucket for the build status
[09:09:43.055] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:43.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:90:0) after 1m0s
[09:10:43.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:90:0)
[09:10:43.092] Timer tick, asking Buildbucket for the build status
[09:10:43.498] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:43.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:91:0) after 1m0s
[09:11:43.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:91:0)
[09:11:43.576] Timer tick, asking Buildbucket for the build status
[09:11:43.730] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:43.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:92:0) after 1m0s
[09:12:43.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:92:0)
[09:12:43.722] Timer tick, asking Buildbucket for the build status
[09:12:44.213] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:44.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:93:0) after 1m0s
[09:13:44.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:93:0)
[09:13:44.249] Timer tick, asking Buildbucket for the build status
[09:13:44.399] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:44.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:94:0) after 1m0s
[09:14:44.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:94:0)
[09:14:44.518] Timer tick, asking Buildbucket for the build status
[09:14:44.733] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:44.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:95:0) after 1m0s
[09:15:44.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:95:0)
[09:15:44.753] Timer tick, asking Buildbucket for the build status
[09:15:44.830] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:44.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:96:0) after 1m0s
[09:16:44.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:96:0)
[09:16:44.879] Timer tick, asking Buildbucket for the build status
[09:16:44.984] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:44.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:97:0) after 1m0s
[09:17:45.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:97:0)
[09:17:45.008] Timer tick, asking Buildbucket for the build status
[09:17:45.407] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:45.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:98:0) after 1m0s
[09:18:45.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:98:0)
[09:18:45.433] Timer tick, asking Buildbucket for the build status
[09:18:45.538] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:45.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:99:0) after 1m0s
[09:19:45.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:99:0)
[09:19:45.584] Timer tick, asking Buildbucket for the build status
[09:19:45.793] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:45.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:100:0) after 1m0s
[09:20:45.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:100:0)
[09:20:45.821] Timer tick, asking Buildbucket for the build status
[09:20:46.025] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:46.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:101:0) after 1m0s
[09:21:46.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:101:0)
[09:21:46.200] Timer tick, asking Buildbucket for the build status
[09:21:46.307] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:46.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:102:0) after 1m0s
[09:22:46.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:102:0)
[09:22:46.331] Timer tick, asking Buildbucket for the build status
[09:22:46.515] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:46.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:103:0) after 1m0s
[09:23:46.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:103:0)
[09:23:46.592] Timer tick, asking Buildbucket for the build status
[09:23:46.725] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:46.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:104:0) after 1m0s
[09:24:46.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:104:0)
[09:24:46.757] Timer tick, asking Buildbucket for the build status
[09:24:46.840] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:46.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:105:0) after 1m0s
[09:25:46.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:105:0)
[09:25:46.911] Timer tick, asking Buildbucket for the build status
[09:25:47.277] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:47.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:106:0) after 1m0s
[09:26:47.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:106:0)
[09:26:47.365] Timer tick, asking Buildbucket for the build status
[09:26:47.443] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:47.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:107:0) after 1m0s
[09:27:47.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:107:0)
[09:27:47.445] Timer tick, asking Buildbucket for the build status
[09:27:47.559] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:47.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:108:0) after 1m0s
[09:28:47.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:108:0)
[09:28:47.555] Timer tick, asking Buildbucket for the build status
[09:28:47.651] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:47.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:109:0) after 1m0s
[09:29:47.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:109:0)
[09:29:47.708] Timer tick, asking Buildbucket for the build status
[09:29:48.035] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:48.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:110:0) after 1m0s
[09:30:48.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:110:0)
[09:30:48.102] Timer tick, asking Buildbucket for the build status
[09:30:48.185] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:48.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:111:0) after 1m0s
[09:31:48.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:111:0)
[09:31:48.214] Timer tick, asking Buildbucket for the build status
[09:31:48.314] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:48.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:112:0) after 1m0s
[09:32:48.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:112:0)
[09:32:48.408] Timer tick, asking Buildbucket for the build status
[09:32:48.532] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:48.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:113:0) after 1m0s
[09:33:48.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:113:0)
[09:33:48.560] Timer tick, asking Buildbucket for the build status
[09:33:48.705] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:48.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:114:0) after 1m0s
[09:34:48.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:114:0)
[09:34:48.794] Timer tick, asking Buildbucket for the build status
[09:34:48.896] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:48.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:115:0) after 1m0s
[09:35:48.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:115:0)
[09:35:48.957] Timer tick, asking Buildbucket for the build status
[09:35:49.046] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:49.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:116:0) after 1m0s
[09:36:49.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:116:0)
[09:36:49.109] Timer tick, asking Buildbucket for the build status
[09:36:49.218] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:49.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:117:0) after 1m0s
[09:37:49.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:117:0)
[09:37:49.301] Timer tick, asking Buildbucket for the build status
[09:37:49.586] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:49.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:118:0) after 1m0s
[09:38:49.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:118:0)
[09:38:49.569] Timer tick, asking Buildbucket for the build status
[09:38:49.692] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:49.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:119:0) after 1m0s
[09:39:49.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:119:0)
[09:39:49.769] Timer tick, asking Buildbucket for the build status
[09:39:49.949] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:49.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:120:0) after 1m0s
[09:40:49.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:120:0)
[09:40:49.972] Timer tick, asking Buildbucket for the build status
[09:40:50.072] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:50.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:121:0) after 1m0s
[09:41:50.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:121:0)
[09:41:50.175] Timer tick, asking Buildbucket for the build status
[09:41:50.515] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:50.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:122:0) after 1m0s
[09:42:50.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:122:0)
[09:42:50.533] Timer tick, asking Buildbucket for the build status
[09:42:50.709] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:50.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:123:0) after 1m0s
[09:43:50.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:123:0)
[09:43:50.754] Timer tick, asking Buildbucket for the build status
[09:43:50.921] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:50.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:124:0) after 1m0s
[09:44:50.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:124:0)
[09:44:50.978] Timer tick, asking Buildbucket for the build status
[09:44:51.087] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:51.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:125:0) after 1m0s
[09:45:51.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:125:0)
[09:45:51.189] Timer tick, asking Buildbucket for the build status
[09:45:51.575] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:51.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:126:0) after 1m0s
[09:46:51.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:126:0)
[09:46:51.668] Timer tick, asking Buildbucket for the build status
[09:46:51.750] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:51.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:127:0) after 1m0s
[09:47:51.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:127:0)
[09:47:51.809] Timer tick, asking Buildbucket for the build status
[09:47:51.985] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:51.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:128:0) after 1m0s
[09:48:52.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:128:0)
[09:48:52.091] Timer tick, asking Buildbucket for the build status
[09:48:52.183] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:52.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:129:0) after 1m0s
[09:49:52.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:129:0)
[09:49:52.236] Timer tick, asking Buildbucket for the build status
[09:49:52.316] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:52.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:130:0) after 1m0s
[09:50:52.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:130:0)
[09:50:52.365] Timer tick, asking Buildbucket for the build status
[09:50:52.437] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:52.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:131:0) after 1m0s
[09:51:52.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:131:0)
[09:51:52.471] Timer tick, asking Buildbucket for the build status
[09:51:52.588] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:52.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:132:0) after 1m0s
[09:52:52.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:132:0)
[09:52:52.614] Timer tick, asking Buildbucket for the build status
[09:52:52.742] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:52.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:133:0) after 1m0s
[09:53:52.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:133:0)
[09:53:52.850] Timer tick, asking Buildbucket for the build status
[09:53:53.098] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:53.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:134:0) after 1m0s
[09:54:53.140] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:134:0)
[09:54:53.140] Timer tick, asking Buildbucket for the build status
[09:54:53.375] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:53.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:135:0) after 1m0s
[09:55:53.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:135:0)
[09:55:53.450] Timer tick, asking Buildbucket for the build status
[09:55:53.602] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:53.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:136:0) after 1m0s
[09:56:53.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:136:0)
[09:56:53.727] Timer tick, asking Buildbucket for the build status
[09:56:53.856] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:53.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:137:0) after 1m0s
[09:57:54.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:137:0)
[09:57:54.089] Timer tick, asking Buildbucket for the build status
[09:57:54.263] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:54.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:138:0) after 1m0s
[09:58:54.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:138:0)
[09:58:54.367] Timer tick, asking Buildbucket for the build status
[09:58:54.441] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:54.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:139:0) after 1m0s
[09:59:54.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:139:0)
[09:59:54.818] Timer tick, asking Buildbucket for the build status
[09:59:54.933] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:54.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:140:0) after 1m0s
[10:00:55.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:140:0)
[10:00:55.109] Timer tick, asking Buildbucket for the build status
[10:00:55.188] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:55.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:141:0) after 1m0s
[10:01:55.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:141:0)
[10:01:55.343] Timer tick, asking Buildbucket for the build status
[10:01:55.408] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:55.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:142:0) after 1m0s
[10:02:55.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:142:0)
[10:02:55.627] Timer tick, asking Buildbucket for the build status
[10:02:56.082] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:56.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:143:0) after 1m0s
[10:03:56.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:143:0)
[10:03:56.236] Timer tick, asking Buildbucket for the build status
[10:03:56.360] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:56.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:144:0) after 1m0s
[10:04:56.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:144:0)
[10:04:56.645] Timer tick, asking Buildbucket for the build status
[10:04:56.864] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:56.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:145:0) after 1m0s
[10:05:56.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:145:0)
[10:05:56.892] Timer tick, asking Buildbucket for the build status
[10:05:57.107] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:57.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:146:0) after 1m0s
[10:06:57.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:146:0)
[10:06:57.283] Timer tick, asking Buildbucket for the build status
[10:06:57.410] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:57.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:147:0) after 1m0s
[10:07:57.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:147:0)
[10:07:57.576] Timer tick, asking Buildbucket for the build status
[10:07:57.684] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:57.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:148:0) after 1m0s
[10:08:57.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:148:0)
[10:08:57.748] Timer tick, asking Buildbucket for the build status
[10:08:57.838] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:57.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:149:0) after 1m0s
[10:09:57.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:149:0)
[10:09:57.875] Timer tick, asking Buildbucket for the build status
[10:09:58.029] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:58.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:150:0) after 1m0s
[10:10:58.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:150:0)
[10:10:58.136] Timer tick, asking Buildbucket for the build status
[10:10:58.250] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:58.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:151:0) after 1m0s
[10:11:58.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:151:0)
[10:11:58.402] Timer tick, asking Buildbucket for the build status
[10:11:58.695] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:58.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:152:0) after 1m0s
[10:12:58.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:152:0)
[10:12:58.741] Timer tick, asking Buildbucket for the build status
[10:12:58.884] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:58.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:153:0) after 1m0s
[10:13:58.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:153:0)
[10:13:58.972] Timer tick, asking Buildbucket for the build status
[10:13:59.143] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:59.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:154:0) after 1m0s
[10:14:59.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:154:0)
[10:14:59.311] Timer tick, asking Buildbucket for the build status
[10:14:59.382] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:59.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:155:0) after 1m0s
[10:15:59.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:155:0)
[10:15:59.476] Timer tick, asking Buildbucket for the build status
[10:15:59.674] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:59.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:156:0) after 1m0s
[10:16:59.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:156:0)
[10:16:59.797] Timer tick, asking Buildbucket for the build status
[10:16:59.866] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:59.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:157:0) after 1m0s
[10:17:59.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:157:0)
[10:17:59.917] Timer tick, asking Buildbucket for the build status
[10:18:00.490] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:00.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:158:0) after 1m0s
[10:19:00.926] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:158:0)
[10:19:00.926] Timer tick, asking Buildbucket for the build status
[10:19:01.013] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:01.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:159:0) after 1m0s
[10:20:01.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:159:0)
[10:20:01.144] Timer tick, asking Buildbucket for the build status
[10:20:01.214] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:01.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:160:0) after 1m0s
[10:21:01.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:160:0)
[10:21:01.312] Timer tick, asking Buildbucket for the build status
[10:21:01.613] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:01.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:161:0) after 1m0s
[10:22:01.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:161:0)
[10:22:01.871] Timer tick, asking Buildbucket for the build status
[10:22:02.020] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:02.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:162:0) after 1m0s
[10:23:02.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:162:0)
[10:23:02.113] Timer tick, asking Buildbucket for the build status
[10:23:02.283] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:02.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:163:0) after 1m0s
[10:24:02.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:163:0)
[10:24:02.330] Timer tick, asking Buildbucket for the build status
[10:24:02.588] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:02.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:164:0) after 1m0s
[10:25:02.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:164:0)
[10:25:02.628] Timer tick, asking Buildbucket for the build status
[10:25:03.004] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:03.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:165:0) after 1m0s
[10:26:03.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:165:0)
[10:26:03.087] Timer tick, asking Buildbucket for the build status
[10:26:03.186] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:03.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:166:0) after 1m0s
[10:27:03.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:166:0)
[10:27:03.250] Timer tick, asking Buildbucket for the build status
[10:27:03.329] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:03.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:167:0) after 1m0s
[10:28:03.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:167:0)
[10:28:03.364] Timer tick, asking Buildbucket for the build status
[10:28:03.668] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:03.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:168:0) after 1m0s
[10:29:03.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:168:0)
[10:29:03.856] Timer tick, asking Buildbucket for the build status
[10:29:03.975] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:03.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:169:0) after 1m0s
[10:30:04.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:169:0)
[10:30:04.147] Timer tick, asking Buildbucket for the build status
[10:30:05.830] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:05.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:170:0) after 1m0s
[10:31:06.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:170:0)
[10:31:06.166] Timer tick, asking Buildbucket for the build status
[10:31:06.257] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:06.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:171:0) after 1m0s
[10:32:06.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:171:0)
[10:32:06.345] Timer tick, asking Buildbucket for the build status
[10:32:06.520] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:06.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:172:0) after 1m0s
[10:33:06.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:172:0)
[10:33:06.647] Timer tick, asking Buildbucket for the build status
[10:33:06.775] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:06.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:173:0) after 1m0s
[10:34:07.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:173:0)
[10:34:07.021] Timer tick, asking Buildbucket for the build status
[10:34:07.084] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:07.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:174:0) after 1m0s
[10:35:07.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:174:0)
[10:35:07.209] Timer tick, asking Buildbucket for the build status
[10:35:07.338] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:07.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:175:0) after 1m0s
[10:36:07.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:175:0)
[10:36:07.479] Timer tick, asking Buildbucket for the build status
[10:36:07.549] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:07.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:176:0) after 1m0s
[10:37:07.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:176:0)
[10:37:07.650] Timer tick, asking Buildbucket for the build status
[10:37:07.762] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:07.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:177:0) after 1m0s
[10:38:07.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:177:0)
[10:38:07.777] Timer tick, asking Buildbucket for the build status
[10:38:07.933] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:07.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:178:0) after 1m0s
[10:39:08.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:178:0)
[10:39:08.026] Timer tick, asking Buildbucket for the build status
[10:39:08.134] Build 8872732692530632416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:08.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038162755308623200:179:0) after 1m0s
[10:40:04.190] Received PubSub notification, asking Buildbucket for the build status
[10:40:04.251] Build 8872732692530632416: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:40:04.251] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1596710402787972",
    "created_by": "project:infra",
    "created_ts": "1596699737003606",
    "id": "8872732692530632416",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4225.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"523af7cc-3692-41ad-bee8-2aa788fd8038\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4225.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-vqrk\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5472-d0af7f3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1596699793910890",
    "status": "COMPLETED",
    "status_changed_ts": "1596710403529489",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038162755308623200",
      "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/8872732692530632416/+/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:4ddb8a065cfa0b10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1596710403698772",
    "url": "https://ci.chromium.org/b/8872732692530632416",
    "utcnow_ts": "1596710404242054"
  }
}
[10:40:04.251] Invocation finished in 2h57m49.2806707s with status SUCCEEDED