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

• parent_buildername:publish_tarball
• user_agent:recipe

[04:05:54.325] New invocation is queued and will start shortly
[04:05:54.325] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[04:05:55.388] Starting the invocation (attempt 1)
[04:05:55.426] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:05:55.426] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:05:55.426] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9036908008990807136",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4183.78\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"fd371f7d-8bab-46aa-8ceb-75456395ceae\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4183.78\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9036908008990807136",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[04:05:55.918] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1597896355520892",
    "id": "8871477947072579184",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4183.78\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"fd371f7d-8bab-46aa-8ceb-75456395ceae\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4183.78\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1597896355758176",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9036908008990807136",
      "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/8871477947072579184/+/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": "1597896355758290",
    "url": "https://ci.chromium.org/b/8871477947072579184",
    "utcnow_ts": "1597896355901785"
  }
}
[04:05:55.918] Task URL: https://ci.chromium.org/b/8871477947072579184
[04:05:55.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:2:0) after 1m0s
[04:06:42.763] Received PubSub notification, asking Buildbucket for the build status
[04:06:42.909] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:55.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:2:0)
[04:06:55.944] Timer tick, asking Buildbucket for the build status
[04:06:56.043] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:56.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:4:0) after 1m0s
[04:07:56.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:4:0)
[04:07:56.048] Timer tick, asking Buildbucket for the build status
[04:07:56.977] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:56.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:5:0) after 1m0s
[04:08:56.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:5:0)
[04:08:56.997] Timer tick, asking Buildbucket for the build status
[04:08:57.384] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:57.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:6:0) after 1m0s
[04:09:57.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:6:0)
[04:09:57.431] Timer tick, asking Buildbucket for the build status
[04:09:57.613] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:57.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:7:0) after 1m0s
[04:10:57.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:7:0)
[04:10:57.672] Timer tick, asking Buildbucket for the build status
[04:10:57.926] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:57.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:8:0) after 1m0s
[04:11:57.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:8:0)
[04:11:57.963] Timer tick, asking Buildbucket for the build status
[04:11:58.103] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:58.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:9:0) after 1m0s
[04:12:58.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:9:0)
[04:12:58.176] Timer tick, asking Buildbucket for the build status
[04:12:58.430] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:58.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:10:0) after 1m0s
[04:13:58.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:10:0)
[04:13:58.478] Timer tick, asking Buildbucket for the build status
[04:13:58.709] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:58.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:11:0) after 1m0s
[04:14:58.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:11:0)
[04:14:58.730] Timer tick, asking Buildbucket for the build status
[04:14:59.155] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:59.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:12:0) after 1m0s
[04:15:59.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:12:0)
[04:15:59.178] Timer tick, asking Buildbucket for the build status
[04:15:59.336] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:59.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:13:0) after 1m0s
[04:16:59.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:13:0)
[04:16:59.354] Timer tick, asking Buildbucket for the build status
[04:16:59.417] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:59.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:14:0) after 1m0s
[04:17:59.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:14:0)
[04:17:59.452] Timer tick, asking Buildbucket for the build status
[04:17:59.524] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:59.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:15:0) after 1m0s
[04:18:59.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:15:0)
[04:18:59.549] Timer tick, asking Buildbucket for the build status
[04:18:59.624] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:59.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:16:0) after 1m0s
[04:19:59.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:16:0)
[04:19:59.739] Timer tick, asking Buildbucket for the build status
[04:19:59.846] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:59.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:17:0) after 1m0s
[04:20:59.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:17:0)
[04:20:59.919] Timer tick, asking Buildbucket for the build status
[04:21:00.182] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:00.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:18:0) after 1m0s
[04:22:01.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:18:0)
[04:22:01.321] Timer tick, asking Buildbucket for the build status
[04:22:01.488] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:01.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:19:0) after 1m0s
[04:23:02.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:19:0)
[04:23:02.283] Timer tick, asking Buildbucket for the build status
[04:23:02.456] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:02.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:20:0) after 1m0s
[04:24:02.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:20:0)
[04:24:02.542] Timer tick, asking Buildbucket for the build status
[04:24:02.697] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:02.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:21:0) after 1m0s
[04:25:02.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:21:0)
[04:25:02.792] Timer tick, asking Buildbucket for the build status
[04:25:02.868] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:02.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:22:0) after 1m0s
[04:26:02.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:22:0)
[04:26:02.890] Timer tick, asking Buildbucket for the build status
[04:26:03.807] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:03.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:23:0) after 1m0s
[04:27:03.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:23:0)
[04:27:03.845] Timer tick, asking Buildbucket for the build status
[04:27:04.089] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:04.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:24:0) after 1m0s
[04:28:04.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:24:0)
[04:28:04.175] Timer tick, asking Buildbucket for the build status
[04:28:04.284] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:04.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:25:0) after 1m0s
[04:29:04.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:25:0)
[04:29:04.377] Timer tick, asking Buildbucket for the build status
[04:29:04.540] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:04.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:26:0) after 1m0s
[04:30:04.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:26:0)
[04:30:04.719] Timer tick, asking Buildbucket for the build status
[04:30:05.841] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:05.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:27:0) after 1m0s
[04:31:05.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:27:0)
[04:31:05.908] Timer tick, asking Buildbucket for the build status
[04:31:06.213] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:06.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:28:0) after 1m0s
[04:32:06.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:28:0)
[04:32:06.262] Timer tick, asking Buildbucket for the build status
[04:32:06.382] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:06.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:29:0) after 1m0s
[04:33:06.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:29:0)
[04:33:06.416] Timer tick, asking Buildbucket for the build status
[04:33:06.534] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:06.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:30:0) after 1m0s
[04:34:06.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:30:0)
[04:34:06.706] Timer tick, asking Buildbucket for the build status
[04:34:07.257] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:07.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:31:0) after 1m0s
[04:35:07.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:31:0)
[04:35:07.306] Timer tick, asking Buildbucket for the build status
[04:35:07.412] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:07.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:32:0) after 1m0s
[04:36:07.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:32:0)
[04:36:07.474] Timer tick, asking Buildbucket for the build status
[04:36:07.584] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:07.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:33:0) after 1m0s
[04:37:07.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:33:0)
[04:37:07.605] Timer tick, asking Buildbucket for the build status
[04:37:07.898] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:07.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:34:0) after 1m0s
[04:38:08.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:34:0)
[04:38:08.037] Timer tick, asking Buildbucket for the build status
[04:38:08.160] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:08.160] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:35:0) after 1m0s
[04:39:08.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:35:0)
[04:39:08.302] Timer tick, asking Buildbucket for the build status
[04:39:08.382] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:08.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:36:0) after 1m0s
[04:40:08.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:36:0)
[04:40:08.446] Timer tick, asking Buildbucket for the build status
[04:40:08.518] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:08.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:37:0) after 1m0s
[04:41:08.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:37:0)
[04:41:08.605] Timer tick, asking Buildbucket for the build status
[04:41:08.811] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:08.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:38:0) after 1m0s
[04:42:08.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:38:0)
[04:42:08.888] Timer tick, asking Buildbucket for the build status
[04:42:09.389] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:09.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:39:0) after 1m0s
[04:43:09.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:39:0)
[04:43:09.493] Timer tick, asking Buildbucket for the build status
[04:43:09.583] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:09.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:40:0) after 1m0s
[04:44:09.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:40:0)
[04:44:09.649] Timer tick, asking Buildbucket for the build status
[04:44:09.726] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:09.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:41:0) after 1m0s
[04:45:09.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:41:0)
[04:45:09.849] Timer tick, asking Buildbucket for the build status
[04:45:10.811] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:10.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:42:0) after 1m0s
[04:46:10.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:42:0)
[04:46:10.848] Timer tick, asking Buildbucket for the build status
[04:46:11.455] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:11.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:43:0) after 1m0s
[04:47:11.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:43:0)
[04:47:11.493] Timer tick, asking Buildbucket for the build status
[04:47:11.699] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:11.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:44:0) after 1m0s
[04:48:11.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:44:0)
[04:48:11.771] Timer tick, asking Buildbucket for the build status
[04:48:11.877] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:11.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:45:0) after 1m0s
[04:49:11.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:45:0)
[04:49:11.928] Timer tick, asking Buildbucket for the build status
[04:49:11.991] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:11.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:46:0) after 1m0s
[04:50:12.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:46:0)
[04:50:12.031] Timer tick, asking Buildbucket for the build status
[04:50:12.145] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:12.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:47:0) after 1m0s
[04:51:12.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:47:0)
[04:51:12.174] Timer tick, asking Buildbucket for the build status
[04:51:12.307] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:12.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:48:0) after 1m0s
[04:52:12.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:48:0)
[04:52:12.365] Timer tick, asking Buildbucket for the build status
[04:52:12.695] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:12.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:49:0) after 1m0s
[04:53:12.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:49:0)
[04:53:12.727] Timer tick, asking Buildbucket for the build status
[04:53:12.898] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:12.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:50:0) after 1m0s
[04:54:12.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:50:0)
[04:54:12.954] Timer tick, asking Buildbucket for the build status
[04:54:13.049] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:13.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:51:0) after 1m0s
[04:55:13.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:51:0)
[04:55:13.106] Timer tick, asking Buildbucket for the build status
[04:55:13.207] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:13.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:52:0) after 1m0s
[04:56:13.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:52:0)
[04:56:13.228] Timer tick, asking Buildbucket for the build status
[04:56:13.334] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:13.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:53:0) after 1m0s
[04:57:13.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:53:0)
[04:57:13.436] Timer tick, asking Buildbucket for the build status
[04:57:13.830] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:13.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:54:0) after 1m0s
[04:58:13.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:54:0)
[04:58:13.856] Timer tick, asking Buildbucket for the build status
[04:58:13.963] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:13.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:55:0) after 1m0s
[04:59:13.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:55:0)
[04:59:13.987] Timer tick, asking Buildbucket for the build status
[04:59:14.255] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:14.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:56:0) after 1m0s
[05:00:14.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:56:0)
[05:00:14.299] Timer tick, asking Buildbucket for the build status
[05:00:14.501] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:14.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:57:0) after 1m0s
[05:01:14.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:57:0)
[05:01:14.553] Timer tick, asking Buildbucket for the build status
[05:01:14.707] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:14.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:58:0) after 1m0s
[05:02:14.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:58:0)
[05:02:14.802] Timer tick, asking Buildbucket for the build status
[05:02:14.878] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:14.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:59:0) after 1m0s
[05:03:15.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:59:0)
[05:03:15.042] Timer tick, asking Buildbucket for the build status
[05:03:15.391] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:15.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:60:0) after 1m0s
[05:04:15.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:60:0)
[05:04:15.433] Timer tick, asking Buildbucket for the build status
[05:04:15.694] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:15.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:61:0) after 1m0s
[05:05:15.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:61:0)
[05:05:15.768] Timer tick, asking Buildbucket for the build status
[05:05:15.920] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:15.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:62:0) after 1m0s
[05:06:15.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:62:0)
[05:06:15.947] Timer tick, asking Buildbucket for the build status
[05:06:16.269] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:16.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:63:0) after 1m0s
[05:07:16.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:63:0)
[05:07:16.287] Timer tick, asking Buildbucket for the build status
[05:07:16.377] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:16.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:64:0) after 1m0s
[05:08:16.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:64:0)
[05:08:16.416] Timer tick, asking Buildbucket for the build status
[05:08:16.498] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:16.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:65:0) after 1m0s
[05:09:16.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:65:0)
[05:09:16.853] Timer tick, asking Buildbucket for the build status
[05:09:17.054] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:17.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:66:0) after 1m0s
[05:10:17.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:66:0)
[05:10:17.310] Timer tick, asking Buildbucket for the build status
[05:10:17.402] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:17.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:67:0) after 1m0s
[05:11:17.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:67:0)
[05:11:17.655] Timer tick, asking Buildbucket for the build status
[05:11:17.765] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:17.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:68:0) after 1m0s
[05:12:17.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:68:0)
[05:12:17.842] Timer tick, asking Buildbucket for the build status
[05:12:18.011] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:18.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:69:0) after 1m0s
[05:13:18.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:69:0)
[05:13:18.161] Timer tick, asking Buildbucket for the build status
[05:13:18.273] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:18.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:70:0) after 1m0s
[05:14:18.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:70:0)
[05:14:18.382] Timer tick, asking Buildbucket for the build status
[05:14:18.557] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:18.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:71:0) after 1m0s
[05:15:18.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:71:0)
[05:15:18.625] Timer tick, asking Buildbucket for the build status
[05:15:18.712] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:18.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:72:0) after 1m0s
[05:16:18.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:72:0)
[05:16:18.892] Timer tick, asking Buildbucket for the build status
[05:16:19.173] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:19.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:73:0) after 1m0s
[05:17:19.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:73:0)
[05:17:19.215] Timer tick, asking Buildbucket for the build status
[05:17:19.302] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:19.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:74:0) after 1m0s
[05:18:19.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:74:0)
[05:18:19.425] Timer tick, asking Buildbucket for the build status
[05:18:19.498] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:19.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:75:0) after 1m0s
[05:19:19.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:75:0)
[05:19:19.536] Timer tick, asking Buildbucket for the build status
[05:19:19.616] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:19.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:76:0) after 1m0s
[05:20:19.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:76:0)
[05:20:19.652] Timer tick, asking Buildbucket for the build status
[05:20:19.751] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:19.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:77:0) after 1m0s
[05:21:19.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:77:0)
[05:21:19.795] Timer tick, asking Buildbucket for the build status
[05:21:19.987] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:19.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:78:0) after 1m0s
[05:22:20.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:78:0)
[05:22:20.147] Timer tick, asking Buildbucket for the build status
[05:22:20.257] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:20.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:79:0) after 1m0s
[05:23:20.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:79:0)
[05:23:20.403] Timer tick, asking Buildbucket for the build status
[05:23:20.630] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:20.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:80:0) after 1m0s
[05:24:20.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:80:0)
[05:24:20.659] Timer tick, asking Buildbucket for the build status
[05:24:20.722] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:20.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:81:0) after 1m0s
[05:25:20.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:81:0)
[05:25:20.762] Timer tick, asking Buildbucket for the build status
[05:25:20.885] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:20.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:82:0) after 1m0s
[05:26:20.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:82:0)
[05:26:20.998] Timer tick, asking Buildbucket for the build status
[05:26:21.203] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:21.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:83:0) after 1m0s
[05:27:21.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:83:0)
[05:27:21.356] Timer tick, asking Buildbucket for the build status
[05:27:21.448] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:21.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:84:0) after 1m0s
[05:28:21.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:84:0)
[05:28:21.590] Timer tick, asking Buildbucket for the build status
[05:28:22.817] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:22.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:85:0) after 1m0s
[05:29:23.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:85:0)
[05:29:23.160] Timer tick, asking Buildbucket for the build status
[05:29:23.247] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:23.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:86:0) after 1m0s
[05:30:23.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:86:0)
[05:30:23.558] Timer tick, asking Buildbucket for the build status
[05:30:23.652] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:23.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:87:0) after 1m0s
[05:31:23.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:87:0)
[05:31:23.979] Timer tick, asking Buildbucket for the build status
[05:31:24.149] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:24.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:88:0) after 1m0s
[05:32:24.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:88:0)
[05:32:24.275] Timer tick, asking Buildbucket for the build status
[05:32:25.696] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:25.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:89:0) after 1m0s
[05:33:25.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:89:0)
[05:33:25.758] Timer tick, asking Buildbucket for the build status
[05:33:25.854] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:25.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:90:0) after 1m0s
[05:34:25.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:90:0)
[05:34:25.930] Timer tick, asking Buildbucket for the build status
[05:34:26.035] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:26.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:91:0) after 1m0s
[05:35:26.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:91:0)
[05:35:26.122] Timer tick, asking Buildbucket for the build status
[05:35:26.581] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:26.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:92:0) after 1m0s
[05:36:26.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:92:0)
[05:36:26.708] Timer tick, asking Buildbucket for the build status
[05:36:27.418] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:27.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:93:0) after 1m0s
[05:37:27.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:93:0)
[05:37:27.433] Timer tick, asking Buildbucket for the build status
[05:37:27.555] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:27.555] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:94:0) after 1m0s
[05:38:27.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:94:0)
[05:38:27.771] Timer tick, asking Buildbucket for the build status
[05:38:27.921] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:27.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:95:0) after 1m0s
[05:39:28.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:95:0)
[05:39:28.186] Timer tick, asking Buildbucket for the build status
[05:39:28.262] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:28.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:96:0) after 1m0s
[05:40:28.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:96:0)
[05:40:28.480] Timer tick, asking Buildbucket for the build status
[05:40:28.563] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:28.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:97:0) after 1m0s
[05:41:28.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:97:0)
[05:41:28.671] Timer tick, asking Buildbucket for the build status
[05:41:28.775] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:28.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:98:0) after 1m0s
[05:42:28.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:98:0)
[05:42:28.923] Timer tick, asking Buildbucket for the build status
[05:42:29.064] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:29.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:99:0) after 1m0s
[05:43:29.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:99:0)
[05:43:29.093] Timer tick, asking Buildbucket for the build status
[05:43:29.707] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:29.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:100:0) after 1m0s
[05:44:29.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:100:0)
[05:44:29.836] Timer tick, asking Buildbucket for the build status
[05:44:29.900] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:29.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:101:0) after 1m0s
[05:45:29.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:101:0)
[05:45:29.962] Timer tick, asking Buildbucket for the build status
[05:45:30.045] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:30.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:102:0) after 1m0s
[05:46:30.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:102:0)
[05:46:30.168] Timer tick, asking Buildbucket for the build status
[05:46:30.357] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:30.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:103:0) after 1m0s
[05:47:30.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:103:0)
[05:47:30.412] Timer tick, asking Buildbucket for the build status
[05:47:30.593] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:30.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:104:0) after 1m0s
[05:48:30.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:104:0)
[05:48:30.596] Timer tick, asking Buildbucket for the build status
[05:48:30.696] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:30.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:105:0) after 1m0s
[05:49:30.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:105:0)
[05:49:30.720] Timer tick, asking Buildbucket for the build status
[05:49:30.813] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:30.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:106:0) after 1m0s
[05:50:30.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:106:0)
[05:50:30.863] Timer tick, asking Buildbucket for the build status
[05:50:30.939] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:30.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:107:0) after 1m0s
[05:51:31.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:107:0)
[05:51:31.158] Timer tick, asking Buildbucket for the build status
[05:51:31.279] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:31.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:108:0) after 1m0s
[05:52:31.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:108:0)
[05:52:31.400] Timer tick, asking Buildbucket for the build status
[05:52:31.527] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:31.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:109:0) after 1m0s
[05:53:31.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:109:0)
[05:53:31.611] Timer tick, asking Buildbucket for the build status
[05:53:31.715] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:31.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:110:0) after 1m0s
[05:54:31.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:110:0)
[05:54:31.739] Timer tick, asking Buildbucket for the build status
[05:54:31.845] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:31.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:111:0) after 1m0s
[05:55:31.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:111:0)
[05:55:31.917] Timer tick, asking Buildbucket for the build status
[05:55:31.982] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:31.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:112:0) after 1m0s
[05:56:31.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:112:0)
[05:56:31.969] Timer tick, asking Buildbucket for the build status
[05:56:32.451] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:32.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:113:0) after 1m0s
[05:57:32.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:113:0)
[05:57:32.515] Timer tick, asking Buildbucket for the build status
[05:57:32.637] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:32.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:114:0) after 1m0s
[05:58:32.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:114:0)
[05:58:32.916] Timer tick, asking Buildbucket for the build status
[05:58:32.999] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:32.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:115:0) after 1m0s
[05:59:33.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:115:0)
[05:59:33.116] Timer tick, asking Buildbucket for the build status
[05:59:33.193] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:33.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:116:0) after 1m0s
[06:00:33.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:116:0)
[06:00:33.395] Timer tick, asking Buildbucket for the build status
[06:00:33.491] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:33.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:117:0) after 1m0s
[06:01:33.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:117:0)
[06:01:33.704] Timer tick, asking Buildbucket for the build status
[06:01:33.909] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:33.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:118:0) after 1m0s
[06:02:33.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:118:0)
[06:02:33.986] Timer tick, asking Buildbucket for the build status
[06:02:34.065] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:34.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:119:0) after 1m0s
[06:03:34.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:119:0)
[06:03:34.265] Timer tick, asking Buildbucket for the build status
[06:03:34.503] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:34.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:120:0) after 1m0s
[06:04:34.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:120:0)
[06:04:34.671] Timer tick, asking Buildbucket for the build status
[06:04:34.964] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:34.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:121:0) after 1m0s
[06:05:35.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:121:0)
[06:05:35.004] Timer tick, asking Buildbucket for the build status
[06:05:35.097] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:35.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:122:0) after 1m0s
[06:06:35.121] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:122:0)
[06:06:35.121] Timer tick, asking Buildbucket for the build status
[06:06:35.354] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:35.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:123:0) after 1m0s
[06:07:35.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:123:0)
[06:07:35.414] Timer tick, asking Buildbucket for the build status
[06:07:35.486] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:35.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:124:0) after 1m0s
[06:08:35.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:124:0)
[06:08:35.508] Timer tick, asking Buildbucket for the build status
[06:08:36.824] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:36.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:125:0) after 1m0s
[06:09:36.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:125:0)
[06:09:36.966] Timer tick, asking Buildbucket for the build status
[06:09:37.043] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:37.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:126:0) after 1m0s
[06:10:37.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:126:0)
[06:10:37.088] Timer tick, asking Buildbucket for the build status
[06:10:37.398] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:37.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:127:0) after 1m0s
[06:11:37.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:127:0)
[06:11:37.544] Timer tick, asking Buildbucket for the build status
[06:11:37.655] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:37.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:128:0) after 1m0s
[06:12:37.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:128:0)
[06:12:37.824] Timer tick, asking Buildbucket for the build status
[06:12:37.907] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:37.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:129:0) after 1m0s
[06:13:38.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:129:0)
[06:13:38.053] Timer tick, asking Buildbucket for the build status
[06:13:38.132] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:38.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:130:0) after 1m0s
[06:14:38.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:130:0)
[06:14:38.419] Timer tick, asking Buildbucket for the build status
[06:14:38.516] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:38.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:131:0) after 1m0s
[06:15:38.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:131:0)
[06:15:38.751] Timer tick, asking Buildbucket for the build status
[06:15:38.890] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:38.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:132:0) after 1m0s
[06:16:38.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:132:0)
[06:16:38.921] Timer tick, asking Buildbucket for the build status
[06:16:39.131] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:39.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:133:0) after 1m0s
[06:17:39.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:133:0)
[06:17:39.485] Timer tick, asking Buildbucket for the build status
[06:17:39.587] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:39.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:134:0) after 1m0s
[06:18:39.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:134:0)
[06:18:39.828] Timer tick, asking Buildbucket for the build status
[06:18:40.229] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:40.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:135:0) after 1m0s
[06:19:40.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:135:0)
[06:19:40.697] Timer tick, asking Buildbucket for the build status
[06:19:40.763] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:40.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:136:0) after 1m0s
[06:20:40.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:136:0)
[06:20:40.892] Timer tick, asking Buildbucket for the build status
[06:20:41.052] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:41.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:137:0) after 1m0s
[06:21:41.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:137:0)
[06:21:41.230] Timer tick, asking Buildbucket for the build status
[06:21:41.359] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:41.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:138:0) after 1m0s
[06:22:41.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:138:0)
[06:22:41.545] Timer tick, asking Buildbucket for the build status
[06:22:41.635] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:41.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:139:0) after 1m0s
[06:23:41.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:139:0)
[06:23:41.912] Timer tick, asking Buildbucket for the build status
[06:23:41.966] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:41.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:140:0) after 1m0s
[06:24:42.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:140:0)
[06:24:42.478] Timer tick, asking Buildbucket for the build status
[06:24:42.559] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:42.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:141:0) after 1m0s
[06:25:42.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:141:0)
[06:25:42.717] Timer tick, asking Buildbucket for the build status
[06:25:42.786] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:42.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:142:0) after 1m0s
[06:26:43.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:142:0)
[06:26:43.144] Timer tick, asking Buildbucket for the build status
[06:26:43.345] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:43.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:143:0) after 1m0s
[06:27:43.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:143:0)
[06:27:43.413] Timer tick, asking Buildbucket for the build status
[06:27:43.492] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:43.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:144:0) after 1m0s
[06:28:43.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:144:0)
[06:28:43.768] Timer tick, asking Buildbucket for the build status
[06:28:43.912] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:43.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:145:0) after 1m0s
[06:29:44.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:145:0)
[06:29:44.094] Timer tick, asking Buildbucket for the build status
[06:29:44.183] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:44.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:146:0) after 1m0s
[06:30:44.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:146:0)
[06:30:44.245] Timer tick, asking Buildbucket for the build status
[06:30:44.693] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:44.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:147:0) after 1m0s
[06:31:44.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:147:0)
[06:31:44.739] Timer tick, asking Buildbucket for the build status
[06:31:44.925] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:44.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:148:0) after 1m0s
[06:32:44.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:148:0)
[06:32:44.979] Timer tick, asking Buildbucket for the build status
[06:32:45.142] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:45.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:149:0) after 1m0s
[06:33:45.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:149:0)
[06:33:45.165] Timer tick, asking Buildbucket for the build status
[06:33:45.337] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:45.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:150:0) after 1m0s
[06:34:45.360] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:150:0)
[06:34:45.360] Timer tick, asking Buildbucket for the build status
[06:34:45.474] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:45.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:151:0) after 1m0s
[06:35:45.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:151:0)
[06:35:45.532] Timer tick, asking Buildbucket for the build status
[06:35:45.829] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:45.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:152:0) after 1m0s
[06:36:45.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:152:0)
[06:36:45.913] Timer tick, asking Buildbucket for the build status
[06:36:46.576] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:46.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:153:0) after 1m0s
[06:37:46.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:153:0)
[06:37:46.625] Timer tick, asking Buildbucket for the build status
[06:37:46.899] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:46.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:154:0) after 1m0s
[06:38:46.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:154:0)
[06:38:46.934] Timer tick, asking Buildbucket for the build status
[06:38:47.026] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:47.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:155:0) after 1m0s
[06:39:47.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:155:0)
[06:39:47.131] Timer tick, asking Buildbucket for the build status
[06:39:47.425] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:47.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:156:0) after 1m0s
[06:40:47.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:156:0)
[06:40:47.468] Timer tick, asking Buildbucket for the build status
[06:40:47.647] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:47.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:157:0) after 1m0s
[06:41:47.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:157:0)
[06:41:47.729] Timer tick, asking Buildbucket for the build status
[06:41:47.913] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:47.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:158:0) after 1m0s
[06:42:47.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:158:0)
[06:42:47.971] Timer tick, asking Buildbucket for the build status
[06:42:48.082] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:48.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:159:0) after 1m0s
[06:43:48.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:159:0)
[06:43:48.169] Timer tick, asking Buildbucket for the build status
[06:43:48.322] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:48.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:160:0) after 1m0s
[06:44:48.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:160:0)
[06:44:48.389] Timer tick, asking Buildbucket for the build status
[06:44:48.720] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:48.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:161:0) after 1m0s
[06:45:48.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:161:0)
[06:45:48.814] Timer tick, asking Buildbucket for the build status
[06:45:48.909] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:48.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:162:0) after 1m0s
[06:46:49.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:162:0)
[06:46:49.035] Timer tick, asking Buildbucket for the build status
[06:46:49.147] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:49.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:163:0) after 1m0s
[06:47:49.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:163:0)
[06:47:49.233] Timer tick, asking Buildbucket for the build status
[06:47:49.315] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:49.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:164:0) after 1m0s
[06:48:49.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:164:0)
[06:48:49.390] Timer tick, asking Buildbucket for the build status
[06:48:49.617] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:49.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:165:0) after 1m0s
[06:49:49.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:165:0)
[06:49:49.674] Timer tick, asking Buildbucket for the build status
[06:49:49.803] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:49.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:166:0) after 1m0s
[06:50:49.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:166:0)
[06:50:49.935] Timer tick, asking Buildbucket for the build status
[06:50:50.003] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:50.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:167:0) after 1m0s
[06:51:50.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:167:0)
[06:51:50.138] Timer tick, asking Buildbucket for the build status
[06:51:50.296] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:50.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:168:0) after 1m0s
[06:52:50.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:168:0)
[06:52:50.368] Timer tick, asking Buildbucket for the build status
[06:52:50.601] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:50.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:169:0) after 1m0s
[06:53:50.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:169:0)
[06:53:50.761] Timer tick, asking Buildbucket for the build status
[06:53:50.835] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:50.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:170:0) after 1m0s
[06:54:50.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:170:0)
[06:54:50.895] Timer tick, asking Buildbucket for the build status
[06:54:51.004] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:51.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:171:0) after 1m0s
[06:55:51.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:171:0)
[06:55:51.098] Timer tick, asking Buildbucket for the build status
[06:55:51.194] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:51.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:172:0) after 1m0s
[06:56:51.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:172:0)
[06:56:51.238] Timer tick, asking Buildbucket for the build status
[06:56:51.394] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:51.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:173:0) after 1m0s
[06:57:51.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:173:0)
[06:57:51.488] Timer tick, asking Buildbucket for the build status
[06:57:51.545] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:51.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:174:0) after 1m0s
[06:58:51.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:174:0)
[06:58:51.577] Timer tick, asking Buildbucket for the build status
[06:58:51.660] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:51.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:175:0) after 1m0s
[06:59:51.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:175:0)
[06:59:51.723] Timer tick, asking Buildbucket for the build status
[06:59:51.799] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:51.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:176:0) after 1m0s
[07:00:51.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:176:0)
[07:00:51.891] Timer tick, asking Buildbucket for the build status
[07:00:51.985] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:51.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:177:0) after 1m0s
[07:01:52.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:177:0)
[07:01:52.296] Timer tick, asking Buildbucket for the build status
[07:01:52.431] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:52.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:178:0) after 1m0s
[07:02:52.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:178:0)
[07:02:52.533] Timer tick, asking Buildbucket for the build status
[07:02:52.598] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:52.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:179:0) after 1m0s
[07:03:52.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:179:0)
[07:03:52.785] Timer tick, asking Buildbucket for the build status
[07:03:52.907] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:52.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:180:0) after 1m0s
[07:04:53.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:180:0)
[07:04:53.233] Timer tick, asking Buildbucket for the build status
[07:04:53.372] Build 8871477947072579184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:53.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036908008990807136:181:0) after 1m0s
[07:04:59.327] Received PubSub notification, asking Buildbucket for the build status
[07:04:59.450] Build 8871477947072579184: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:04:59.451] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1597907098517761",
    "created_by": "project:infra",
    "created_ts": "1597896355520892",
    "id": "8871477947072579184",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4183.78\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"fd371f7d-8bab-46aa-8ceb-75456395ceae\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4183.78\"}}",
    "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-n33d\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5498-3454aa6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1597896401577701",
    "status": "COMPLETED",
    "status_changed_ts": "1597907098842444",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9036908008990807136",
      "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/8871477947072579184/+/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:4e22dcfa22d38710",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1597907098856380",
    "url": "https://ci.chromium.org/b/8871477947072579184",
    "utcnow_ts": "1597907099436703"
  }
}
[07:04:59.451] Invocation finished in 2h59m5.14382753s with status SUCCEEDED