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

• parent_buildername:publish_tarball
• user_agent:recipe

[08:09:41.392] New invocation is queued and will start shortly
[08:09:41.392] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:09:42.645] Starting the invocation (attempt 1)
[08:09:42.686] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:09:42.686] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:09:42.686] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9040969534888212176",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4194.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"48c9f6c3-9fd8-465c-a901-20f705659cbe\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4194.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:9040969534888212176",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:09:43.655] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1594022982832965",
    "id": "8875539472712299888",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4194.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"48c9f6c3-9fd8-465c-a901-20f705659cbe\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4194.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1594022983368703",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9040969534888212176",
      "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/8875539472712299888/+/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": "1594022983368873",
    "url": "https://ci.chromium.org/b/8875539472712299888",
    "utcnow_ts": "1594022983640682"
  }
}
[08:09:43.655] Task URL: https://ci.chromium.org/b/8875539472712299888
[08:09:43.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:2:0) after 1m0s
[08:10:11.655] Received PubSub notification, asking Buildbucket for the build status
[08:10:12.520] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:43.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:2:0)
[08:10:43.787] Timer tick, asking Buildbucket for the build status
[08:10:43.902] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:43.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:4:0) after 1m0s
[08:11:44.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:4:0)
[08:11:44.002] Timer tick, asking Buildbucket for the build status
[08:11:44.188] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:44.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:5:0) after 1m0s
[08:12:44.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:5:0)
[08:12:44.300] Timer tick, asking Buildbucket for the build status
[08:12:44.579] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:44.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:6:0) after 1m0s
[08:13:44.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:6:0)
[08:13:44.709] Timer tick, asking Buildbucket for the build status
[08:13:44.838] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:44.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:7:0) after 1m0s
[08:14:44.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:7:0)
[08:14:44.884] Timer tick, asking Buildbucket for the build status
[08:14:45.321] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:45.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:8:0) after 1m0s
[08:15:45.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:8:0)
[08:15:45.395] Timer tick, asking Buildbucket for the build status
[08:15:45.519] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:45.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:9:0) after 1m0s
[08:16:45.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:9:0)
[08:16:45.671] Timer tick, asking Buildbucket for the build status
[08:16:45.829] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:45.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:10:0) after 1m0s
[08:17:45.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:10:0)
[08:17:45.853] Timer tick, asking Buildbucket for the build status
[08:17:46.365] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:46.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:11:0) after 1m0s
[08:18:46.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:11:0)
[08:18:46.486] Timer tick, asking Buildbucket for the build status
[08:18:46.880] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:46.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:12:0) after 1m0s
[08:19:46.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:12:0)
[08:19:46.874] Timer tick, asking Buildbucket for the build status
[08:19:47.318] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:47.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:13:0) after 1m0s
[08:20:47.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:13:0)
[08:20:47.454] Timer tick, asking Buildbucket for the build status
[08:20:47.766] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:47.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:14:0) after 1m0s
[08:21:47.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:14:0)
[08:21:47.774] Timer tick, asking Buildbucket for the build status
[08:21:47.853] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:47.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:15:0) after 1m0s
[08:22:47.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:15:0)
[08:22:47.874] Timer tick, asking Buildbucket for the build status
[08:22:48.998] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:48.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:16:0) after 1m0s
[08:23:49.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:16:0)
[08:23:49.022] Timer tick, asking Buildbucket for the build status
[08:23:49.396] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:49.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:17:0) after 1m0s
[08:24:49.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:17:0)
[08:24:49.434] Timer tick, asking Buildbucket for the build status
[08:24:49.568] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:49.568] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:18:0) after 1m0s
[08:25:49.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:18:0)
[08:25:49.619] Timer tick, asking Buildbucket for the build status
[08:25:49.787] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:49.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:19:0) after 1m0s
[08:26:49.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:19:0)
[08:26:49.847] Timer tick, asking Buildbucket for the build status
[08:26:50.152] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:50.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:20:0) after 1m0s
[08:27:50.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:20:0)
[08:27:50.197] Timer tick, asking Buildbucket for the build status
[08:27:52.110] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:52.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:21:0) after 1m0s
[08:28:52.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:21:0)
[08:28:52.108] Timer tick, asking Buildbucket for the build status
[08:28:52.222] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:52.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:22:0) after 1m0s
[08:29:52.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:22:0)
[08:29:52.268] Timer tick, asking Buildbucket for the build status
[08:29:52.523] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:52.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:23:0) after 1m0s
[08:30:52.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:23:0)
[08:30:52.546] Timer tick, asking Buildbucket for the build status
[08:30:52.703] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:52.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:24:0) after 1m0s
[08:31:52.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:24:0)
[08:31:52.728] Timer tick, asking Buildbucket for the build status
[08:31:52.948] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:52.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:25:0) after 1m0s
[08:32:53.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:25:0)
[08:32:53.013] Timer tick, asking Buildbucket for the build status
[08:32:54.356] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:54.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:26:0) after 1m0s
[08:33:54.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:26:0)
[08:33:54.409] Timer tick, asking Buildbucket for the build status
[08:33:54.548] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:54.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:27:0) after 1m0s
[08:34:54.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:27:0)
[08:34:54.578] Timer tick, asking Buildbucket for the build status
[08:34:54.936] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:54.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:28:0) after 1m0s
[08:35:55.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:28:0)
[08:35:55.011] Timer tick, asking Buildbucket for the build status
[08:35:56.439] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:56.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:29:0) after 1m0s
[08:36:56.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:29:0)
[08:36:56.952] Timer tick, asking Buildbucket for the build status
[08:36:57.091] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:57.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:30:0) after 1m0s
[08:37:57.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:30:0)
[08:37:57.609] Timer tick, asking Buildbucket for the build status
[08:37:58.584] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:58.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:31:0) after 1m0s
[08:38:58.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:31:0)
[08:38:58.655] Timer tick, asking Buildbucket for the build status
[08:38:58.812] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:58.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:32:0) after 1m0s
[08:39:58.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:32:0)
[08:39:58.851] Timer tick, asking Buildbucket for the build status
[08:39:59.021] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:59.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:33:0) after 1m0s
[08:40:59.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:33:0)
[08:40:59.044] Timer tick, asking Buildbucket for the build status
[08:40:59.318] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:59.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:34:0) after 1m0s
[08:41:59.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:34:0)
[08:41:59.310] Timer tick, asking Buildbucket for the build status
[08:42:00.241] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:00.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:35:0) after 1m0s
[08:43:06.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:35:0)
[08:43:06.073] Timer tick, asking Buildbucket for the build status
[08:43:06.370] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:06.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:36:0) after 1m0s
[08:44:06.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:36:0)
[08:44:06.470] Timer tick, asking Buildbucket for the build status
[08:44:06.588] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:06.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:37:0) after 1m0s
[08:45:06.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:37:0)
[08:45:06.664] Timer tick, asking Buildbucket for the build status
[08:45:06.768] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:06.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:38:0) after 1m0s
[08:46:06.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:38:0)
[08:46:06.812] Timer tick, asking Buildbucket for the build status
[08:46:07.121] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:07.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:39:0) after 1m0s
[08:47:07.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:39:0)
[08:47:07.148] Timer tick, asking Buildbucket for the build status
[08:47:07.506] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:07.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:40:0) after 1m0s
[08:48:07.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:40:0)
[08:48:07.529] Timer tick, asking Buildbucket for the build status
[08:48:07.727] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:07.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:41:0) after 1m0s
[08:49:07.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:41:0)
[08:49:07.727] Timer tick, asking Buildbucket for the build status
[08:49:07.839] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:07.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:42:0) after 1m0s
[08:50:07.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:42:0)
[08:50:07.865] Timer tick, asking Buildbucket for the build status
[08:50:07.987] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:07.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:43:0) after 1m0s
[08:51:08.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:43:0)
[08:51:08.038] Timer tick, asking Buildbucket for the build status
[08:51:08.179] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:08.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:44:0) after 1m0s
[08:52:08.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:44:0)
[08:52:08.203] Timer tick, asking Buildbucket for the build status
[08:52:08.305] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:08.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:45:0) after 1m0s
[08:53:08.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:45:0)
[08:53:08.327] Timer tick, asking Buildbucket for the build status
[08:53:08.690] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:08.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:46:0) after 1m0s
[08:54:08.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:46:0)
[08:54:08.692] Timer tick, asking Buildbucket for the build status
[08:54:08.830] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:08.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:47:0) after 1m0s
[08:55:08.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:47:0)
[08:55:08.893] Timer tick, asking Buildbucket for the build status
[08:55:09.289] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:09.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:48:0) after 1m0s
[08:56:09.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:48:0)
[08:56:09.297] Timer tick, asking Buildbucket for the build status
[08:56:09.774] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:09.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:49:0) after 1m0s
[08:57:09.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:49:0)
[08:57:09.830] Timer tick, asking Buildbucket for the build status
[08:57:09.949] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:09.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:50:0) after 1m0s
[08:58:09.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:50:0)
[08:58:09.973] Timer tick, asking Buildbucket for the build status
[08:58:10.441] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:10.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:51:0) after 1m0s
[08:59:10.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:51:0)
[08:59:10.475] Timer tick, asking Buildbucket for the build status
[08:59:10.839] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:10.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:52:0) after 1m0s
[09:00:10.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:52:0)
[09:00:10.877] Timer tick, asking Buildbucket for the build status
[09:00:11.184] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:11.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:53:0) after 1m0s
[09:01:11.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:53:0)
[09:01:11.181] Timer tick, asking Buildbucket for the build status
[09:01:11.376] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:11.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:54:0) after 1m0s
[09:02:11.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:54:0)
[09:02:11.527] Timer tick, asking Buildbucket for the build status
[09:02:11.669] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:11.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:55:0) after 1m0s
[09:03:11.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:55:0)
[09:03:11.752] Timer tick, asking Buildbucket for the build status
[09:03:11.975] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:11.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:56:0) after 1m0s
[09:04:12.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:56:0)
[09:04:12.052] Timer tick, asking Buildbucket for the build status
[09:04:12.252] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:12.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:57:0) after 1m0s
[09:05:12.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:57:0)
[09:05:12.381] Timer tick, asking Buildbucket for the build status
[09:05:12.589] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:12.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:58:0) after 1m0s
[09:06:12.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:58:0)
[09:06:12.719] Timer tick, asking Buildbucket for the build status
[09:06:12.845] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:12.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:59:0) after 1m0s
[09:07:12.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:59:0)
[09:07:12.904] Timer tick, asking Buildbucket for the build status
[09:07:13.108] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:13.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:60:0) after 1m0s
[09:08:13.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:60:0)
[09:08:13.137] Timer tick, asking Buildbucket for the build status
[09:08:13.395] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:13.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:61:0) after 1m0s
[09:09:13.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:61:0)
[09:09:13.427] Timer tick, asking Buildbucket for the build status
[09:09:13.577] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:13.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:62:0) after 1m0s
[09:10:13.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:62:0)
[09:10:13.599] Timer tick, asking Buildbucket for the build status
[09:10:13.757] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:13.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:63:0) after 1m0s
[09:11:13.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:63:0)
[09:11:13.833] Timer tick, asking Buildbucket for the build status
[09:11:14.013] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:14.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:64:0) after 1m0s
[09:12:14.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:64:0)
[09:12:14.014] Timer tick, asking Buildbucket for the build status
[09:12:14.339] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:14.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:65:0) after 1m0s
[09:13:14.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:65:0)
[09:13:14.481] Timer tick, asking Buildbucket for the build status
[09:13:14.622] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:14.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:66:0) after 1m0s
[09:14:14.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:66:0)
[09:14:14.818] Timer tick, asking Buildbucket for the build status
[09:14:15.121] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:15.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:67:0) after 1m0s
[09:15:15.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:67:0)
[09:15:15.394] Timer tick, asking Buildbucket for the build status
[09:15:15.639] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:15.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:68:0) after 1m0s
[09:16:17.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:68:0)
[09:16:17.123] Timer tick, asking Buildbucket for the build status
[09:16:17.353] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:17.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:69:0) after 1m0s
[09:17:17.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:69:0)
[09:17:17.511] Timer tick, asking Buildbucket for the build status
[09:17:17.692] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:17.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:70:0) after 1m0s
[09:18:18.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:70:0)
[09:18:18.468] Timer tick, asking Buildbucket for the build status
[09:18:19.145] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:19.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:71:0) after 1m0s
[09:19:20.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:71:0)
[09:19:20.267] Timer tick, asking Buildbucket for the build status
[09:19:20.434] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:20.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:72:0) after 1m0s
[09:20:20.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:72:0)
[09:20:20.490] Timer tick, asking Buildbucket for the build status
[09:20:20.660] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:20.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:73:0) after 1m0s
[09:21:20.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:73:0)
[09:21:20.652] Timer tick, asking Buildbucket for the build status
[09:21:21.211] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:21.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:74:0) after 1m0s
[09:22:21.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:74:0)
[09:22:21.474] Timer tick, asking Buildbucket for the build status
[09:22:21.591] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:21.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:75:0) after 1m0s
[09:23:21.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:75:0)
[09:23:21.919] Timer tick, asking Buildbucket for the build status
[09:23:22.120] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:22.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:76:0) after 1m0s
[09:24:22.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:76:0)
[09:24:22.407] Timer tick, asking Buildbucket for the build status
[09:24:22.567] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:22.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:77:0) after 1m0s
[09:25:22.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:77:0)
[09:25:22.824] Timer tick, asking Buildbucket for the build status
[09:25:23.078] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:23.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:78:0) after 1m0s
[09:26:23.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:78:0)
[09:26:23.286] Timer tick, asking Buildbucket for the build status
[09:26:23.579] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:23.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:79:0) after 1m0s
[09:27:23.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:79:0)
[09:27:23.677] Timer tick, asking Buildbucket for the build status
[09:27:23.974] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:23.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:80:0) after 1m0s
[09:28:24.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:80:0)
[09:28:24.122] Timer tick, asking Buildbucket for the build status
[09:28:24.341] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:24.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:81:0) after 1m0s
[09:29:24.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:81:0)
[09:29:24.407] Timer tick, asking Buildbucket for the build status
[09:29:24.567] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:24.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:82:0) after 1m0s
[09:30:24.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:82:0)
[09:30:24.677] Timer tick, asking Buildbucket for the build status
[09:30:24.780] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:24.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:83:0) after 1m0s
[09:31:24.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:83:0)
[09:31:24.927] Timer tick, asking Buildbucket for the build status
[09:31:25.098] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:25.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:84:0) after 1m0s
[09:32:25.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:84:0)
[09:32:25.139] Timer tick, asking Buildbucket for the build status
[09:32:25.298] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:25.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:85:0) after 1m0s
[09:33:25.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:85:0)
[09:33:25.386] Timer tick, asking Buildbucket for the build status
[09:33:25.531] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:25.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:86:0) after 1m0s
[09:34:25.663] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:86:0)
[09:34:25.663] Timer tick, asking Buildbucket for the build status
[09:34:25.810] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:25.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:87:0) after 1m0s
[09:35:25.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:87:0)
[09:35:25.903] Timer tick, asking Buildbucket for the build status
[09:35:26.052] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:26.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:88:0) after 1m0s
[09:36:26.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:88:0)
[09:36:26.156] Timer tick, asking Buildbucket for the build status
[09:36:26.353] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:26.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:89:0) after 1m0s
[09:37:26.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:89:0)
[09:37:26.418] Timer tick, asking Buildbucket for the build status
[09:37:26.661] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:26.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:90:0) after 1m0s
[09:38:26.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:90:0)
[09:38:26.872] Timer tick, asking Buildbucket for the build status
[09:38:27.036] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:27.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:91:0) after 1m0s
[09:39:27.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:91:0)
[09:39:27.144] Timer tick, asking Buildbucket for the build status
[09:39:27.275] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:27.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:92:0) after 1m0s
[09:40:27.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:92:0)
[09:40:27.335] Timer tick, asking Buildbucket for the build status
[09:40:27.453] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:27.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:93:0) after 1m0s
[09:41:27.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:93:0)
[09:41:27.492] Timer tick, asking Buildbucket for the build status
[09:41:27.762] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:27.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:94:0) after 1m0s
[09:42:27.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:94:0)
[09:42:27.754] Timer tick, asking Buildbucket for the build status
[09:42:29.421] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:29.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:95:0) after 1m0s
[09:43:29.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:95:0)
[09:43:29.526] Timer tick, asking Buildbucket for the build status
[09:43:29.711] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:29.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:96:0) after 1m0s
[09:44:29.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:96:0)
[09:44:29.733] Timer tick, asking Buildbucket for the build status
[09:44:29.917] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:29.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:97:0) after 1m0s
[09:45:29.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:97:0)
[09:45:29.995] Timer tick, asking Buildbucket for the build status
[09:45:30.175] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:30.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:98:0) after 1m0s
[09:46:30.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:98:0)
[09:46:30.211] Timer tick, asking Buildbucket for the build status
[09:46:30.363] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:30.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:99:0) after 1m0s
[09:47:30.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:99:0)
[09:47:30.393] Timer tick, asking Buildbucket for the build status
[09:47:30.938] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:30.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:100:0) after 1m0s
[09:48:31.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:100:0)
[09:48:31.014] Timer tick, asking Buildbucket for the build status
[09:48:31.179] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:31.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:101:0) after 1m0s
[09:49:31.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:101:0)
[09:49:31.232] Timer tick, asking Buildbucket for the build status
[09:49:31.595] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:31.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:102:0) after 1m0s
[09:50:31.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:102:0)
[09:50:31.623] Timer tick, asking Buildbucket for the build status
[09:50:31.891] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:31.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:103:0) after 1m0s
[09:51:31.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:103:0)
[09:51:31.922] Timer tick, asking Buildbucket for the build status
[09:51:32.106] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:32.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:104:0) after 1m0s
[09:52:32.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:104:0)
[09:52:32.135] Timer tick, asking Buildbucket for the build status
[09:52:32.502] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:32.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:105:0) after 1m0s
[09:53:32.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:105:0)
[09:53:32.498] Timer tick, asking Buildbucket for the build status
[09:53:32.596] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:32.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:106:0) after 1m0s
[09:54:32.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:106:0)
[09:54:32.623] Timer tick, asking Buildbucket for the build status
[09:54:32.809] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:32.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:107:0) after 1m0s
[09:55:32.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:107:0)
[09:55:32.935] Timer tick, asking Buildbucket for the build status
[09:55:33.272] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:33.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:108:0) after 1m0s
[09:56:33.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:108:0)
[09:56:33.313] Timer tick, asking Buildbucket for the build status
[09:56:33.509] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:33.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:109:0) after 1m0s
[09:57:33.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:109:0)
[09:57:33.536] Timer tick, asking Buildbucket for the build status
[09:57:34.230] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:34.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:110:0) after 1m0s
[09:58:34.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:110:0)
[09:58:34.292] Timer tick, asking Buildbucket for the build status
[09:58:34.553] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:34.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:111:0) after 1m0s
[09:59:34.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:111:0)
[09:59:34.656] Timer tick, asking Buildbucket for the build status
[09:59:35.151] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:35.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:112:0) after 1m0s
[10:00:35.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:112:0)
[10:00:35.227] Timer tick, asking Buildbucket for the build status
[10:00:35.715] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:35.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:113:0) after 1m0s
[10:01:35.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:113:0)
[10:01:35.739] Timer tick, asking Buildbucket for the build status
[10:01:36.133] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:36.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:114:0) after 1m0s
[10:02:36.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:114:0)
[10:02:36.210] Timer tick, asking Buildbucket for the build status
[10:02:38.768] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:38.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:115:0) after 1m0s
[10:03:38.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:115:0)
[10:03:38.750] Timer tick, asking Buildbucket for the build status
[10:03:39.193] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:39.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:116:0) after 1m0s
[10:04:39.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:116:0)
[10:04:39.356] Timer tick, asking Buildbucket for the build status
[10:04:39.565] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:39.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:117:0) after 1m0s
[10:05:39.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:117:0)
[10:05:39.662] Timer tick, asking Buildbucket for the build status
[10:05:39.958] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:39.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:118:0) after 1m0s
[10:06:40.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:118:0)
[10:06:40.152] Timer tick, asking Buildbucket for the build status
[10:06:40.612] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:40.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:119:0) after 1m0s
[10:07:40.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:119:0)
[10:07:40.719] Timer tick, asking Buildbucket for the build status
[10:07:44.234] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:44.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:120:0) after 1m0s
[10:08:44.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:120:0)
[10:08:44.263] Timer tick, asking Buildbucket for the build status
[10:08:44.390] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:44.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:121:0) after 1m0s
[10:09:44.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:121:0)
[10:09:44.368] Timer tick, asking Buildbucket for the build status
[10:09:44.543] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:44.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:122:0) after 1m0s
[10:10:44.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:122:0)
[10:10:44.651] Timer tick, asking Buildbucket for the build status
[10:10:45.103] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:45.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:123:0) after 1m0s
[10:11:45.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:123:0)
[10:11:45.326] Timer tick, asking Buildbucket for the build status
[10:11:45.475] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:45.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:124:0) after 1m0s
[10:12:45.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:124:0)
[10:12:45.518] Timer tick, asking Buildbucket for the build status
[10:12:46.246] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:46.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:125:0) after 1m0s
[10:13:46.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:125:0)
[10:13:46.376] Timer tick, asking Buildbucket for the build status
[10:13:46.521] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:46.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:126:0) after 1m0s
[10:14:46.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:126:0)
[10:14:46.633] Timer tick, asking Buildbucket for the build status
[10:14:46.747] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:46.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:127:0) after 1m0s
[10:15:46.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:127:0)
[10:15:46.791] Timer tick, asking Buildbucket for the build status
[10:15:46.942] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:46.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:128:0) after 1m0s
[10:16:47.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:128:0)
[10:16:47.029] Timer tick, asking Buildbucket for the build status
[10:16:47.158] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:47.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:129:0) after 1m0s
[10:17:47.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:129:0)
[10:17:47.241] Timer tick, asking Buildbucket for the build status
[10:17:47.438] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:47.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:130:0) after 1m0s
[10:18:47.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:130:0)
[10:18:47.497] Timer tick, asking Buildbucket for the build status
[10:18:47.644] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:47.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:131:0) after 1m0s
[10:19:47.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:131:0)
[10:19:47.715] Timer tick, asking Buildbucket for the build status
[10:19:47.957] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:47.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:132:0) after 1m0s
[10:20:47.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:132:0)
[10:20:47.985] Timer tick, asking Buildbucket for the build status
[10:20:48.154] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:48.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:133:0) after 1m0s
[10:21:48.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:133:0)
[10:21:48.182] Timer tick, asking Buildbucket for the build status
[10:21:49.223] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:49.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:134:0) after 1m0s
[10:22:49.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:134:0)
[10:22:49.213] Timer tick, asking Buildbucket for the build status
[10:22:50.043] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:50.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:135:0) after 1m0s
[10:23:50.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:135:0)
[10:23:50.074] Timer tick, asking Buildbucket for the build status
[10:23:50.262] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:50.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:136:0) after 1m0s
[10:24:50.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:136:0)
[10:24:50.309] Timer tick, asking Buildbucket for the build status
[10:24:50.469] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:50.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:137:0) after 1m0s
[10:25:50.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:137:0)
[10:25:50.697] Timer tick, asking Buildbucket for the build status
[10:25:50.913] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:50.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:138:0) after 1m0s
[10:26:51.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:138:0)
[10:26:51.095] Timer tick, asking Buildbucket for the build status
[10:26:51.293] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:51.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:139:0) after 1m0s
[10:27:51.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:139:0)
[10:27:51.368] Timer tick, asking Buildbucket for the build status
[10:27:58.105] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:58.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:140:0) after 1m0s
[10:28:58.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:140:0)
[10:28:58.099] Timer tick, asking Buildbucket for the build status
[10:28:58.520] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:58.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:141:0) after 1m0s
[10:29:58.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:141:0)
[10:29:58.601] Timer tick, asking Buildbucket for the build status
[10:29:58.741] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:58.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:142:0) after 1m0s
[10:30:58.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:142:0)
[10:30:58.767] Timer tick, asking Buildbucket for the build status
[10:30:58.931] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:58.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:143:0) after 1m0s
[10:31:58.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:143:0)
[10:31:58.960] Timer tick, asking Buildbucket for the build status
[10:31:59.118] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:59.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:144:0) after 1m0s
[10:32:59.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:144:0)
[10:32:59.146] Timer tick, asking Buildbucket for the build status
[10:32:59.872] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:59.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:145:0) after 1m0s
[10:33:59.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:145:0)
[10:33:59.904] Timer tick, asking Buildbucket for the build status
[10:34:00.223] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:00.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:146:0) after 1m0s
[10:35:00.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:146:0)
[10:35:00.594] Timer tick, asking Buildbucket for the build status
[10:35:00.951] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:00.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:147:0) after 1m0s
[10:36:00.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:147:0)
[10:36:00.931] Timer tick, asking Buildbucket for the build status
[10:36:01.397] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:01.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:148:0) after 1m0s
[10:37:01.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:148:0)
[10:37:01.463] Timer tick, asking Buildbucket for the build status
[10:37:01.592] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:01.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:149:0) after 1m0s
[10:38:01.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:149:0)
[10:38:01.620] Timer tick, asking Buildbucket for the build status
[10:38:01.771] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:01.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:150:0) after 1m0s
[10:39:02.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:150:0)
[10:39:02.196] Timer tick, asking Buildbucket for the build status
[10:39:02.355] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:02.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:151:0) after 1m0s
[10:40:02.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:151:0)
[10:40:02.389] Timer tick, asking Buildbucket for the build status
[10:40:02.917] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:02.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:152:0) after 1m0s
[10:41:02.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:152:0)
[10:41:02.996] Timer tick, asking Buildbucket for the build status
[10:41:03.393] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:03.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:153:0) after 1m0s
[10:42:03.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:153:0)
[10:42:03.484] Timer tick, asking Buildbucket for the build status
[10:42:03.734] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:03.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:154:0) after 1m0s
[10:43:03.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:154:0)
[10:43:03.809] Timer tick, asking Buildbucket for the build status
[10:43:04.074] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:04.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:155:0) after 1m0s
[10:44:04.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:155:0)
[10:44:04.103] Timer tick, asking Buildbucket for the build status
[10:44:04.236] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:04.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:156:0) after 1m0s
[10:45:04.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:156:0)
[10:45:04.313] Timer tick, asking Buildbucket for the build status
[10:45:04.507] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:04.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:157:0) after 1m0s
[10:46:04.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:157:0)
[10:46:04.564] Timer tick, asking Buildbucket for the build status
[10:46:04.731] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:04.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:158:0) after 1m0s
[10:47:04.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:158:0)
[10:47:04.785] Timer tick, asking Buildbucket for the build status
[10:47:04.940] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:04.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:159:0) after 1m0s
[10:48:04.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:159:0)
[10:48:04.955] Timer tick, asking Buildbucket for the build status
[10:48:05.319] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:05.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:160:0) after 1m0s
[10:49:05.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:160:0)
[10:49:05.356] Timer tick, asking Buildbucket for the build status
[10:49:05.498] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:05.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:161:0) after 1m0s
[10:50:05.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:161:0)
[10:50:05.589] Timer tick, asking Buildbucket for the build status
[10:50:05.731] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:05.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:162:0) after 1m0s
[10:51:05.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:162:0)
[10:51:05.720] Timer tick, asking Buildbucket for the build status
[10:51:05.869] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:05.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:163:0) after 1m0s
[10:52:06.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:163:0)
[10:52:06.014] Timer tick, asking Buildbucket for the build status
[10:52:06.173] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:06.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:164:0) after 1m0s
[10:53:06.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:164:0)
[10:53:06.226] Timer tick, asking Buildbucket for the build status
[10:53:06.503] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:06.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:165:0) after 1m0s
[10:54:06.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:165:0)
[10:54:06.566] Timer tick, asking Buildbucket for the build status
[10:54:06.815] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:06.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:166:0) after 1m0s
[10:55:06.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:166:0)
[10:55:06.908] Timer tick, asking Buildbucket for the build status
[10:55:07.074] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:07.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:167:0) after 1m0s
[10:56:07.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:167:0)
[10:56:07.068] Timer tick, asking Buildbucket for the build status
[10:56:07.221] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:07.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:168:0) after 1m0s
[10:57:07.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:168:0)
[10:57:07.282] Timer tick, asking Buildbucket for the build status
[10:57:07.587] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:07.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:169:0) after 1m0s
[10:58:07.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:169:0)
[10:58:07.661] Timer tick, asking Buildbucket for the build status
[10:58:07.986] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:07.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:170:0) after 1m0s
[10:59:08.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:170:0)
[10:59:08.009] Timer tick, asking Buildbucket for the build status
[10:59:08.528] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:08.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:171:0) after 1m0s
[11:00:08.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:171:0)
[11:00:08.650] Timer tick, asking Buildbucket for the build status
[11:00:09.120] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:09.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:172:0) after 1m0s
[11:01:09.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:172:0)
[11:01:09.198] Timer tick, asking Buildbucket for the build status
[11:01:09.340] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:09.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:173:0) after 1m0s
[11:02:09.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:173:0)
[11:02:09.369] Timer tick, asking Buildbucket for the build status
[11:02:09.641] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:09.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:174:0) after 1m0s
[11:03:09.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:174:0)
[11:03:09.675] Timer tick, asking Buildbucket for the build status
[11:03:09.839] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:09.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:175:0) after 1m0s
[11:04:09.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:175:0)
[11:04:09.870] Timer tick, asking Buildbucket for the build status
[11:04:10.022] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:10.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:176:0) after 1m0s
[11:05:10.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:176:0)
[11:05:10.176] Timer tick, asking Buildbucket for the build status
[11:05:10.501] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:10.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:177:0) after 1m0s
[11:06:10.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:177:0)
[11:06:10.577] Timer tick, asking Buildbucket for the build status
[11:06:10.996] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:10.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:178:0) after 1m0s
[11:07:11.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:178:0)
[11:07:11.107] Timer tick, asking Buildbucket for the build status
[11:07:11.395] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:11.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:179:0) after 1m0s
[11:08:11.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:179:0)
[11:08:11.507] Timer tick, asking Buildbucket for the build status
[11:08:11.695] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:11.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:180:0) after 1m0s
[11:09:11.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:180:0)
[11:09:11.728] Timer tick, asking Buildbucket for the build status
[11:09:11.888] Build 8875539472712299888: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:11.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040969534888212176:181:0) after 1m0s
[11:10:03.207] Received PubSub notification, asking Buildbucket for the build status
[11:10:03.454] Build 8875539472712299888: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:10:03.454] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1594033802329562",
    "created_by": "project:infra",
    "created_ts": "1594022982832965",
    "id": "8875539472712299888",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4194.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"48c9f6c3-9fd8-465c-a901-20f705659cbe\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4194.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-fsuk\"], \"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.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5320-752003c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1594023010527866",
    "status": "COMPLETED",
    "status_changed_ts": "1594033802873341",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9040969534888212176",
      "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/8875539472712299888/+/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:4d3bfe0051dd5410",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1594033802896690",
    "url": "https://ci.chromium.org/b/8875539472712299888",
    "utcnow_ts": "1594033803313789"
  }
}
[11:10:03.454] Invocation finished in 3h0m22.081431953s with status SUCCEEDED