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

• parent_buildername:publish_tarball
• user_agent:recipe

[07:41:33.141] New invocation is queued and will start shortly
[07:41:33.141] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[07:41:34.488] Starting the invocation (attempt 1)
[07:41:34.546] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:41:34.546] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:41:34.546] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9038615784022005568",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4219.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"02d53f7e-ca92-49e4-adc9-2285cc858048\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4219.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:9038615784022005568",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[07:41:38.483] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1596267694663419",
    "id": "8873185721759185008",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4219.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"02d53f7e-ca92-49e4-adc9-2285cc858048\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4219.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1596267698178771",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038615784022005568",
      "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/8873185721759185008/+/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": "1596267698178918",
    "url": "https://ci.chromium.org/b/8873185721759185008",
    "utcnow_ts": "1596267698461741"
  }
}
[07:41:38.483] Task URL: https://ci.chromium.org/b/8873185721759185008
[07:41:38.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:2:0) after 1m0s
[07:42:31.618] Received PubSub notification, asking Buildbucket for the build status
[07:42:31.831] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:38.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:2:0)
[07:42:38.557] Timer tick, asking Buildbucket for the build status
[07:42:38.696] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:38.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:4:0) after 1m0s
[07:43:38.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:4:0)
[07:43:38.723] Timer tick, asking Buildbucket for the build status
[07:43:38.935] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:38.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:5:0) after 1m0s
[07:44:38.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:5:0)
[07:44:38.993] Timer tick, asking Buildbucket for the build status
[07:44:39.109] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:39.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:6:0) after 1m0s
[07:45:39.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:6:0)
[07:45:39.213] Timer tick, asking Buildbucket for the build status
[07:45:39.270] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:39.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:7:0) after 1m0s
[07:46:39.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:7:0)
[07:46:39.375] Timer tick, asking Buildbucket for the build status
[07:46:39.919] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:39.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:8:0) after 1m0s
[07:47:39.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:8:0)
[07:47:39.954] Timer tick, asking Buildbucket for the build status
[07:47:40.207] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:40.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:9:0) after 1m0s
[07:48:40.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:9:0)
[07:48:40.362] Timer tick, asking Buildbucket for the build status
[07:48:40.601] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:40.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:10:0) after 1m0s
[07:49:40.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:10:0)
[07:49:40.684] Timer tick, asking Buildbucket for the build status
[07:49:40.995] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:40.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:11:0) after 1m0s
[07:50:41.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:11:0)
[07:50:41.106] Timer tick, asking Buildbucket for the build status
[07:50:41.201] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:41.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:12:0) after 1m0s
[07:51:41.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:12:0)
[07:51:41.227] Timer tick, asking Buildbucket for the build status
[07:51:41.483] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:41.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:13:0) after 1m0s
[07:52:41.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:13:0)
[07:52:41.502] Timer tick, asking Buildbucket for the build status
[07:52:41.649] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:41.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:14:0) after 1m0s
[07:53:41.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:14:0)
[07:53:41.654] Timer tick, asking Buildbucket for the build status
[07:53:41.712] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:41.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:15:0) after 1m0s
[07:54:41.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:15:0)
[07:54:41.738] Timer tick, asking Buildbucket for the build status
[07:54:41.828] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:41.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:16:0) after 1m0s
[07:55:41.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:16:0)
[07:55:41.854] Timer tick, asking Buildbucket for the build status
[07:55:41.999] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:41.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:17:0) after 1m0s
[07:56:42.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:17:0)
[07:56:42.023] Timer tick, asking Buildbucket for the build status
[07:56:42.129] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:42.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:18:0) after 1m0s
[07:57:42.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:18:0)
[07:57:42.199] Timer tick, asking Buildbucket for the build status
[07:57:42.589] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:42.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:19:0) after 1m0s
[07:58:42.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:19:0)
[07:58:42.606] Timer tick, asking Buildbucket for the build status
[07:58:43.083] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:43.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:20:0) after 1m0s
[07:59:43.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:20:0)
[07:59:43.161] Timer tick, asking Buildbucket for the build status
[07:59:43.372] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:43.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:21:0) after 1m0s
[08:00:43.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:21:0)
[08:00:43.407] Timer tick, asking Buildbucket for the build status
[08:00:43.601] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:43.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:22:0) after 1m0s
[08:01:43.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:22:0)
[08:01:43.736] Timer tick, asking Buildbucket for the build status
[08:01:43.891] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:43.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:23:0) after 1m0s
[08:02:43.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:23:0)
[08:02:43.925] Timer tick, asking Buildbucket for the build status
[08:02:44.011] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:44.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:24:0) after 1m0s
[08:03:44.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:24:0)
[08:03:44.049] Timer tick, asking Buildbucket for the build status
[08:03:44.313] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:44.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:25:0) after 1m0s
[08:04:44.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:25:0)
[08:04:44.349] Timer tick, asking Buildbucket for the build status
[08:04:44.602] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:44.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:26:0) after 1m0s
[08:05:44.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:26:0)
[08:05:44.631] Timer tick, asking Buildbucket for the build status
[08:05:44.778] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:44.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:27:0) after 1m0s
[08:06:44.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:27:0)
[08:06:44.800] Timer tick, asking Buildbucket for the build status
[08:06:44.965] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:44.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:28:0) after 1m0s
[08:07:45.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:28:0)
[08:07:45.026] Timer tick, asking Buildbucket for the build status
[08:07:45.181] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:45.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:29:0) after 1m0s
[08:08:45.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:29:0)
[08:08:45.203] Timer tick, asking Buildbucket for the build status
[08:08:45.345] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:45.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:30:0) after 1m0s
[08:09:45.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:30:0)
[08:09:45.370] Timer tick, asking Buildbucket for the build status
[08:09:45.477] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:45.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:31:0) after 1m0s
[08:10:45.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:31:0)
[08:10:45.536] Timer tick, asking Buildbucket for the build status
[08:10:45.621] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:45.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:32:0) after 1m0s
[08:11:45.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:32:0)
[08:11:45.679] Timer tick, asking Buildbucket for the build status
[08:11:45.843] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:45.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:33:0) after 1m0s
[08:12:45.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:33:0)
[08:12:45.873] Timer tick, asking Buildbucket for the build status
[08:12:46.056] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:46.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:34:0) after 1m0s
[08:13:46.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:34:0)
[08:13:46.086] Timer tick, asking Buildbucket for the build status
[08:13:46.496] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:46.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:35:0) after 1m0s
[08:14:46.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:35:0)
[08:14:46.523] Timer tick, asking Buildbucket for the build status
[08:14:46.594] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:46.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:36:0) after 1m0s
[08:15:46.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:36:0)
[08:15:46.623] Timer tick, asking Buildbucket for the build status
[08:15:46.724] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:46.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:37:0) after 1m0s
[08:16:46.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:37:0)
[08:16:46.775] Timer tick, asking Buildbucket for the build status
[08:16:46.910] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:46.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:38:0) after 1m0s
[08:17:46.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:38:0)
[08:17:46.938] Timer tick, asking Buildbucket for the build status
[08:17:47.232] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:47.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:39:0) after 1m0s
[08:18:47.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:39:0)
[08:18:47.353] Timer tick, asking Buildbucket for the build status
[08:18:47.534] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:47.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:40:0) after 1m0s
[08:19:47.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:40:0)
[08:19:47.588] Timer tick, asking Buildbucket for the build status
[08:19:47.677] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:47.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:41:0) after 1m0s
[08:20:47.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:41:0)
[08:20:47.735] Timer tick, asking Buildbucket for the build status
[08:20:47.841] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:47.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:42:0) after 1m0s
[08:21:47.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:42:0)
[08:21:47.905] Timer tick, asking Buildbucket for the build status
[08:21:48.656] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:48.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:43:0) after 1m0s
[08:22:48.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:43:0)
[08:22:48.690] Timer tick, asking Buildbucket for the build status
[08:22:48.776] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:48.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:44:0) after 1m0s
[08:23:48.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:44:0)
[08:23:48.803] Timer tick, asking Buildbucket for the build status
[08:23:48.883] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:48.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:45:0) after 1m0s
[08:24:48.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:45:0)
[08:24:48.938] Timer tick, asking Buildbucket for the build status
[08:24:49.174] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:49.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:46:0) after 1m0s
[08:25:49.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:46:0)
[08:25:49.203] Timer tick, asking Buildbucket for the build status
[08:25:49.272] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:49.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:47:0) after 1m0s
[08:26:49.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:47:0)
[08:26:49.278] Timer tick, asking Buildbucket for the build status
[08:26:49.389] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:49.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:48:0) after 1m0s
[08:27:49.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:48:0)
[08:27:49.411] Timer tick, asking Buildbucket for the build status
[08:27:49.497] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:49.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:49:0) after 1m0s
[08:28:49.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:49:0)
[08:28:49.523] Timer tick, asking Buildbucket for the build status
[08:28:49.592] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:49.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:50:0) after 1m0s
[08:29:49.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:50:0)
[08:29:49.659] Timer tick, asking Buildbucket for the build status
[08:29:50.412] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:50.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:51:0) after 1m0s
[08:30:50.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:51:0)
[08:30:50.482] Timer tick, asking Buildbucket for the build status
[08:30:50.667] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:50.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:52:0) after 1m0s
[08:31:50.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:52:0)
[08:31:50.709] Timer tick, asking Buildbucket for the build status
[08:31:50.837] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:50.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:53:0) after 1m0s
[08:32:50.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:53:0)
[08:32:50.862] Timer tick, asking Buildbucket for the build status
[08:32:51.041] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:51.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:54:0) after 1m0s
[08:33:51.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:54:0)
[08:33:51.031] Timer tick, asking Buildbucket for the build status
[08:33:51.113] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:51.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:55:0) after 1m0s
[08:34:51.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:55:0)
[08:34:51.137] Timer tick, asking Buildbucket for the build status
[08:34:51.368] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:51.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:56:0) after 1m0s
[08:35:51.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:56:0)
[08:35:51.394] Timer tick, asking Buildbucket for the build status
[08:35:51.479] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:51.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:57:0) after 1m0s
[08:36:51.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:57:0)
[08:36:51.501] Timer tick, asking Buildbucket for the build status
[08:36:51.621] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:51.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:58:0) after 1m0s
[08:37:51.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:58:0)
[08:37:51.639] Timer tick, asking Buildbucket for the build status
[08:37:54.150] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:54.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:59:0) after 1m0s
[08:38:54.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:59:0)
[08:38:54.199] Timer tick, asking Buildbucket for the build status
[08:38:54.306] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:54.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:60:0) after 1m0s
[08:39:54.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:60:0)
[08:39:54.443] Timer tick, asking Buildbucket for the build status
[08:39:54.719] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:54.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:61:0) after 1m0s
[08:40:54.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:61:0)
[08:40:54.791] Timer tick, asking Buildbucket for the build status
[08:40:54.856] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:54.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:62:0) after 1m0s
[08:41:54.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:62:0)
[08:41:54.836] Timer tick, asking Buildbucket for the build status
[08:41:55.025] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:55.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:63:0) after 1m0s
[08:42:55.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:63:0)
[08:42:55.053] Timer tick, asking Buildbucket for the build status
[08:42:55.151] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:55.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:64:0) after 1m0s
[08:43:55.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:64:0)
[08:43:55.178] Timer tick, asking Buildbucket for the build status
[08:43:55.302] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:55.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:65:0) after 1m0s
[08:44:55.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:65:0)
[08:44:55.435] Timer tick, asking Buildbucket for the build status
[08:44:55.503] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:55.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:66:0) after 1m0s
[08:45:55.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:66:0)
[08:45:55.623] Timer tick, asking Buildbucket for the build status
[08:45:55.720] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:55.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:67:0) after 1m0s
[08:46:55.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:67:0)
[08:46:55.811] Timer tick, asking Buildbucket for the build status
[08:46:55.974] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:55.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:68:0) after 1m0s
[08:47:56.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:68:0)
[08:47:56.051] Timer tick, asking Buildbucket for the build status
[08:47:56.136] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:56.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:69:0) after 1m0s
[08:48:56.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:69:0)
[08:48:56.217] Timer tick, asking Buildbucket for the build status
[08:48:56.302] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:56.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:70:0) after 1m0s
[08:49:56.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:70:0)
[08:49:56.293] Timer tick, asking Buildbucket for the build status
[08:49:56.373] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:56.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:71:0) after 1m0s
[08:50:56.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:71:0)
[08:50:56.407] Timer tick, asking Buildbucket for the build status
[08:50:56.473] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:56.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:72:0) after 1m0s
[08:51:56.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:72:0)
[08:51:56.548] Timer tick, asking Buildbucket for the build status
[08:51:56.679] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:56.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:73:0) after 1m0s
[08:52:56.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:73:0)
[08:52:56.706] Timer tick, asking Buildbucket for the build status
[08:52:56.796] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:56.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:74:0) after 1m0s
[08:53:56.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:74:0)
[08:53:56.887] Timer tick, asking Buildbucket for the build status
[08:53:56.951] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:56.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:75:0) after 1m0s
[08:54:57.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:75:0)
[08:54:57.074] Timer tick, asking Buildbucket for the build status
[08:54:57.153] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:57.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:76:0) after 1m0s
[08:55:57.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:76:0)
[08:55:57.296] Timer tick, asking Buildbucket for the build status
[08:55:57.460] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:57.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:77:0) after 1m0s
[08:56:57.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:77:0)
[08:56:57.533] Timer tick, asking Buildbucket for the build status
[08:56:57.651] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:57.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:78:0) after 1m0s
[08:57:57.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:78:0)
[08:57:57.685] Timer tick, asking Buildbucket for the build status
[08:57:57.772] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:57.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:79:0) after 1m0s
[08:58:57.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:79:0)
[08:58:57.895] Timer tick, asking Buildbucket for the build status
[08:58:57.974] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:57.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:80:0) after 1m0s
[08:59:58.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:80:0)
[08:59:58.148] Timer tick, asking Buildbucket for the build status
[08:59:58.300] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:58.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:81:0) after 1m0s
[09:00:58.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:81:0)
[09:00:58.325] Timer tick, asking Buildbucket for the build status
[09:00:58.413] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:58.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:82:0) after 1m0s
[09:01:58.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:82:0)
[09:01:58.545] Timer tick, asking Buildbucket for the build status
[09:01:59.112] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:59.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:83:0) after 1m0s
[09:02:59.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:83:0)
[09:02:59.213] Timer tick, asking Buildbucket for the build status
[09:02:59.515] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:59.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:84:0) after 1m0s
[09:03:59.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:84:0)
[09:03:59.550] Timer tick, asking Buildbucket for the build status
[09:03:59.665] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:59.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:85:0) after 1m0s
[09:04:59.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:85:0)
[09:04:59.692] Timer tick, asking Buildbucket for the build status
[09:04:59.745] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:59.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:86:0) after 1m0s
[09:05:59.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:86:0)
[09:05:59.789] Timer tick, asking Buildbucket for the build status
[09:05:59.890] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:59.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:87:0) after 1m0s
[09:07:00.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:87:0)
[09:07:00.061] Timer tick, asking Buildbucket for the build status
[09:07:00.459] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:00.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:88:0) after 1m0s
[09:08:00.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:88:0)
[09:08:00.996] Timer tick, asking Buildbucket for the build status
[09:08:01.054] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:01.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:89:0) after 1m0s
[09:09:01.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:89:0)
[09:09:01.086] Timer tick, asking Buildbucket for the build status
[09:09:01.218] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:01.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:90:0) after 1m0s
[09:10:01.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:90:0)
[09:10:01.964] Timer tick, asking Buildbucket for the build status
[09:10:02.094] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:02.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:91:0) after 1m0s
[09:11:02.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:91:0)
[09:11:02.118] Timer tick, asking Buildbucket for the build status
[09:11:02.466] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:02.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:92:0) after 1m0s
[09:12:02.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:92:0)
[09:12:02.564] Timer tick, asking Buildbucket for the build status
[09:12:02.693] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:02.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:93:0) after 1m0s
[09:13:02.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:93:0)
[09:13:02.673] Timer tick, asking Buildbucket for the build status
[09:13:02.834] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:02.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:94:0) after 1m0s
[09:14:03.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:94:0)
[09:14:03.247] Timer tick, asking Buildbucket for the build status
[09:14:03.340] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:03.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:95:0) after 1m0s
[09:15:03.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:95:0)
[09:15:03.397] Timer tick, asking Buildbucket for the build status
[09:15:03.647] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:03.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:96:0) after 1m0s
[09:16:03.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:96:0)
[09:16:03.695] Timer tick, asking Buildbucket for the build status
[09:16:03.763] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:03.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:97:0) after 1m0s
[09:17:03.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:97:0)
[09:17:03.789] Timer tick, asking Buildbucket for the build status
[09:17:03.924] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:03.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:98:0) after 1m0s
[09:18:04.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:98:0)
[09:18:04.017] Timer tick, asking Buildbucket for the build status
[09:18:04.392] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:04.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:99:0) after 1m0s
[09:19:04.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:99:0)
[09:19:04.415] Timer tick, asking Buildbucket for the build status
[09:19:04.600] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:04.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:100:0) after 1m0s
[09:20:04.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:100:0)
[09:20:04.732] Timer tick, asking Buildbucket for the build status
[09:20:04.795] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:04.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:101:0) after 1m0s
[09:21:04.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:101:0)
[09:21:04.844] Timer tick, asking Buildbucket for the build status
[09:21:04.919] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:04.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:102:0) after 1m0s
[09:22:05.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:102:0)
[09:22:05.052] Timer tick, asking Buildbucket for the build status
[09:22:05.199] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:05.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:103:0) after 1m0s
[09:23:05.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:103:0)
[09:23:05.321] Timer tick, asking Buildbucket for the build status
[09:23:05.495] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:05.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:104:0) after 1m0s
[09:24:05.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:104:0)
[09:24:05.568] Timer tick, asking Buildbucket for the build status
[09:24:05.719] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:05.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:105:0) after 1m0s
[09:25:05.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:105:0)
[09:25:05.812] Timer tick, asking Buildbucket for the build status
[09:25:06.255] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:06.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:106:0) after 1m0s
[09:26:06.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:106:0)
[09:26:06.383] Timer tick, asking Buildbucket for the build status
[09:26:06.642] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:06.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:107:0) after 1m0s
[09:27:06.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:107:0)
[09:27:06.746] Timer tick, asking Buildbucket for the build status
[09:27:06.881] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:06.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:108:0) after 1m0s
[09:28:06.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:108:0)
[09:28:06.908] Timer tick, asking Buildbucket for the build status
[09:28:07.031] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:07.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:109:0) after 1m0s
[09:29:07.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:109:0)
[09:29:07.102] Timer tick, asking Buildbucket for the build status
[09:29:07.171] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:07.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:110:0) after 1m0s
[09:30:07.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:110:0)
[09:30:07.335] Timer tick, asking Buildbucket for the build status
[09:30:07.430] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:07.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:111:0) after 1m0s
[09:31:07.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:111:0)
[09:31:07.539] Timer tick, asking Buildbucket for the build status
[09:31:07.637] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:07.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:112:0) after 1m0s
[09:32:07.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:112:0)
[09:32:07.668] Timer tick, asking Buildbucket for the build status
[09:32:07.843] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:07.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:113:0) after 1m0s
[09:33:07.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:113:0)
[09:33:07.911] Timer tick, asking Buildbucket for the build status
[09:33:08.291] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:08.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:114:0) after 1m0s
[09:34:08.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:114:0)
[09:34:08.374] Timer tick, asking Buildbucket for the build status
[09:34:08.646] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:08.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:115:0) after 1m0s
[09:35:08.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:115:0)
[09:35:08.776] Timer tick, asking Buildbucket for the build status
[09:35:08.854] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:08.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:116:0) after 1m0s
[09:36:08.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:116:0)
[09:36:08.884] Timer tick, asking Buildbucket for the build status
[09:36:08.959] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:08.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:117:0) after 1m0s
[09:37:09.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:117:0)
[09:37:09.123] Timer tick, asking Buildbucket for the build status
[09:37:09.243] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:09.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:118:0) after 1m0s
[09:38:09.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:118:0)
[09:38:09.250] Timer tick, asking Buildbucket for the build status
[09:38:09.414] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:09.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:119:0) after 1m0s
[09:39:09.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:119:0)
[09:39:09.476] Timer tick, asking Buildbucket for the build status
[09:39:09.536] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:09.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:120:0) after 1m0s
[09:40:09.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:120:0)
[09:40:09.518] Timer tick, asking Buildbucket for the build status
[09:40:09.588] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:09.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:121:0) after 1m0s
[09:41:09.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:121:0)
[09:41:09.667] Timer tick, asking Buildbucket for the build status
[09:41:10.294] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:10.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:122:0) after 1m0s
[09:42:10.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:122:0)
[09:42:10.322] Timer tick, asking Buildbucket for the build status
[09:42:10.800] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:10.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:123:0) after 1m0s
[09:43:10.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:123:0)
[09:43:10.834] Timer tick, asking Buildbucket for the build status
[09:43:10.906] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:10.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:124:0) after 1m0s
[09:44:10.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:124:0)
[09:44:10.982] Timer tick, asking Buildbucket for the build status
[09:44:11.358] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:11.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:125:0) after 1m0s
[09:45:11.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:125:0)
[09:45:11.490] Timer tick, asking Buildbucket for the build status
[09:45:11.649] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:11.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:126:0) after 1m0s
[09:46:11.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:126:0)
[09:46:11.814] Timer tick, asking Buildbucket for the build status
[09:46:11.923] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:11.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:127:0) after 1m0s
[09:47:11.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:127:0)
[09:47:11.951] Timer tick, asking Buildbucket for the build status
[09:47:12.100] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:12.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:128:0) after 1m0s
[09:48:12.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:128:0)
[09:48:12.144] Timer tick, asking Buildbucket for the build status
[09:48:12.212] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:12.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:129:0) after 1m0s
[09:49:12.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:129:0)
[09:49:12.319] Timer tick, asking Buildbucket for the build status
[09:49:12.435] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:12.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:130:0) after 1m0s
[09:50:12.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:130:0)
[09:50:12.480] Timer tick, asking Buildbucket for the build status
[09:50:12.549] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:12.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:131:0) after 1m0s
[09:51:12.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:131:0)
[09:51:12.606] Timer tick, asking Buildbucket for the build status
[09:51:12.670] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:12.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:132:0) after 1m0s
[09:52:12.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:132:0)
[09:52:12.729] Timer tick, asking Buildbucket for the build status
[09:52:13.082] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:13.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:133:0) after 1m0s
[09:53:13.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:133:0)
[09:53:13.087] Timer tick, asking Buildbucket for the build status
[09:53:13.146] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:13.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:134:0) after 1m0s
[09:54:13.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:134:0)
[09:54:13.290] Timer tick, asking Buildbucket for the build status
[09:54:13.363] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:13.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:135:0) after 1m0s
[09:55:13.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:135:0)
[09:55:13.554] Timer tick, asking Buildbucket for the build status
[09:55:13.725] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:13.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:136:0) after 1m0s
[09:56:13.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:136:0)
[09:56:13.823] Timer tick, asking Buildbucket for the build status
[09:56:13.888] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:13.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:137:0) after 1m0s
[09:57:13.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:137:0)
[09:57:13.941] Timer tick, asking Buildbucket for the build status
[09:57:14.041] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:14.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:138:0) after 1m0s
[09:58:14.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:138:0)
[09:58:14.051] Timer tick, asking Buildbucket for the build status
[09:58:14.139] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:14.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:139:0) after 1m0s
[09:59:14.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:139:0)
[09:59:14.190] Timer tick, asking Buildbucket for the build status
[09:59:14.259] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:14.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:140:0) after 1m0s
[10:00:14.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:140:0)
[10:00:14.379] Timer tick, asking Buildbucket for the build status
[10:00:14.443] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:14.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:141:0) after 1m0s
[10:01:14.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:141:0)
[10:01:14.530] Timer tick, asking Buildbucket for the build status
[10:01:14.788] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:14.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:142:0) after 1m0s
[10:02:15.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:142:0)
[10:02:15.033] Timer tick, asking Buildbucket for the build status
[10:02:15.244] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:15.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:143:0) after 1m0s
[10:03:15.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:143:0)
[10:03:15.262] Timer tick, asking Buildbucket for the build status
[10:03:15.331] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:15.331] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:144:0) after 1m0s
[10:04:15.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:144:0)
[10:04:15.362] Timer tick, asking Buildbucket for the build status
[10:04:20.816] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:20.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:145:0) after 1m0s
[10:05:20.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:145:0)
[10:05:20.803] Timer tick, asking Buildbucket for the build status
[10:05:20.864] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:20.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:146:0) after 1m0s
[10:06:21.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:146:0)
[10:06:21.018] Timer tick, asking Buildbucket for the build status
[10:06:21.166] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:21.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:147:0) after 1m0s
[10:07:21.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:147:0)
[10:07:21.209] Timer tick, asking Buildbucket for the build status
[10:07:21.373] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:21.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:148:0) after 1m0s
[10:08:21.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:148:0)
[10:08:21.504] Timer tick, asking Buildbucket for the build status
[10:08:21.594] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:21.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:149:0) after 1m0s
[10:09:21.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:149:0)
[10:09:21.708] Timer tick, asking Buildbucket for the build status
[10:09:21.895] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:21.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:150:0) after 1m0s
[10:10:22.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:150:0)
[10:10:22.049] Timer tick, asking Buildbucket for the build status
[10:10:22.175] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:22.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:151:0) after 1m0s
[10:11:22.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:151:0)
[10:11:22.199] Timer tick, asking Buildbucket for the build status
[10:11:22.273] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:22.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:152:0) after 1m0s
[10:12:22.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:152:0)
[10:12:22.315] Timer tick, asking Buildbucket for the build status
[10:12:22.423] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:22.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:153:0) after 1m0s
[10:13:22.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:153:0)
[10:13:22.455] Timer tick, asking Buildbucket for the build status
[10:13:22.681] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:22.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:154:0) after 1m0s
[10:14:22.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:154:0)
[10:14:22.721] Timer tick, asking Buildbucket for the build status
[10:14:22.818] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:22.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:155:0) after 1m0s
[10:15:22.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:155:0)
[10:15:22.893] Timer tick, asking Buildbucket for the build status
[10:15:23.118] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:23.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:156:0) after 1m0s
[10:16:23.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:156:0)
[10:16:23.192] Timer tick, asking Buildbucket for the build status
[10:16:23.251] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:23.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:157:0) after 1m0s
[10:17:23.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:157:0)
[10:17:23.305] Timer tick, asking Buildbucket for the build status
[10:17:23.767] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:23.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:158:0) after 1m0s
[10:18:23.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:158:0)
[10:18:23.921] Timer tick, asking Buildbucket for the build status
[10:18:23.985] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:23.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:159:0) after 1m0s
[10:19:24.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:159:0)
[10:19:24.032] Timer tick, asking Buildbucket for the build status
[10:19:24.110] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:24.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:160:0) after 1m0s
[10:20:24.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:160:0)
[10:20:24.195] Timer tick, asking Buildbucket for the build status
[10:20:24.306] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:24.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:161:0) after 1m0s
[10:21:24.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:161:0)
[10:21:24.358] Timer tick, asking Buildbucket for the build status
[10:21:24.441] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:24.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:162:0) after 1m0s
[10:22:24.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:162:0)
[10:22:24.539] Timer tick, asking Buildbucket for the build status
[10:22:25.048] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:25.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:163:0) after 1m0s
[10:23:25.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:163:0)
[10:23:25.113] Timer tick, asking Buildbucket for the build status
[10:23:25.191] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:25.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:164:0) after 1m0s
[10:24:25.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:164:0)
[10:24:25.246] Timer tick, asking Buildbucket for the build status
[10:24:25.418] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:25.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:165:0) after 1m0s
[10:25:25.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:165:0)
[10:25:25.449] Timer tick, asking Buildbucket for the build status
[10:25:25.531] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:25.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:166:0) after 1m0s
[10:26:25.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:166:0)
[10:26:25.577] Timer tick, asking Buildbucket for the build status
[10:26:25.649] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:25.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:167:0) after 1m0s
[10:27:25.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:167:0)
[10:27:25.696] Timer tick, asking Buildbucket for the build status
[10:27:25.833] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:25.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:168:0) after 1m0s
[10:28:25.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:168:0)
[10:28:25.831] Timer tick, asking Buildbucket for the build status
[10:28:25.925] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:25.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:169:0) after 1m0s
[10:29:25.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:169:0)
[10:29:25.999] Timer tick, asking Buildbucket for the build status
[10:29:26.095] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:26.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:170:0) after 1m0s
[10:30:26.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:170:0)
[10:30:26.278] Timer tick, asking Buildbucket for the build status
[10:30:26.415] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:26.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:171:0) after 1m0s
[10:31:26.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:171:0)
[10:31:26.496] Timer tick, asking Buildbucket for the build status
[10:31:26.691] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:26.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:172:0) after 1m0s
[10:32:27.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:172:0)
[10:32:27.488] Timer tick, asking Buildbucket for the build status
[10:32:27.622] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:27.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:173:0) after 1m0s
[10:33:27.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:173:0)
[10:33:27.609] Timer tick, asking Buildbucket for the build status
[10:33:28.481] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:28.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:174:0) after 1m0s
[10:34:28.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:174:0)
[10:34:28.557] Timer tick, asking Buildbucket for the build status
[10:34:28.713] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:28.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:175:0) after 1m0s
[10:35:28.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:175:0)
[10:35:28.784] Timer tick, asking Buildbucket for the build status
[10:35:28.848] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:28.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:176:0) after 1m0s
[10:36:28.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:176:0)
[10:36:28.902] Timer tick, asking Buildbucket for the build status
[10:36:29.193] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:29.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:177:0) after 1m0s
[10:37:29.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:177:0)
[10:37:29.254] Timer tick, asking Buildbucket for the build status
[10:37:29.364] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:29.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:178:0) after 1m0s
[10:38:29.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:178:0)
[10:38:29.441] Timer tick, asking Buildbucket for the build status
[10:38:29.612] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:29.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:179:0) after 1m0s
[10:39:29.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:179:0)
[10:39:29.648] Timer tick, asking Buildbucket for the build status
[10:39:29.771] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:29.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:180:0) after 1m0s
[10:40:29.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:180:0)
[10:40:29.767] Timer tick, asking Buildbucket for the build status
[10:40:29.996] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:29.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:181:0) after 1m0s
[10:41:30.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:181:0)
[10:41:30.106] Timer tick, asking Buildbucket for the build status
[10:41:30.204] Build 8873185721759185008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:30.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038615784022005568:182:0) after 1m0s
[10:41:43.894] Received PubSub notification, asking Buildbucket for the build status
[10:41:43.965] Build 8873185721759185008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:41:43.966] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1596278503185601",
    "created_by": "project:infra",
    "created_ts": "1596267694663419",
    "id": "8873185721759185008",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4219.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"02d53f7e-ca92-49e4-adc9-2285cc858048\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4219.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-njm1\"], \"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\": [\"5436-adf7f8a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1596267750723725",
    "status": "COMPLETED",
    "status_changed_ts": "1596278503626657",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038615784022005568",
      "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/8873185721759185008/+/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:4dc1c9a8a4f1d910",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1596278503642616",
    "url": "https://ci.chromium.org/b/8873185721759185008",
    "utcnow_ts": "1596278503953956"
  }
}
[10:41:43.966] Invocation finished in 3h0m10.843687513s with status SUCCEEDED