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

• parent_buildername:publish_tarball
• user_agent:recipe

[20:09:47.557] New invocation is queued and will start shortly
[20:09:47.557] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[20:09:48.779] Starting the invocation (attempt 1)
[20:09:48.823] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:09:48.823] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:09:48.824] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9035035427121589440",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4240.30\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"c3e051c3-739a-4eb1-a174-e693a655b62f\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4240.30\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9035035427121589440",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[20:09:49.879] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1599682188987183",
    "id": "8869605364959030896",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.30\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"c3e051c3-739a-4eb1-a174-e693a655b62f\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.30\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1599682189526655",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9035035427121589440",
      "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/8869605364959030896/+/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": "1599682189526773",
    "url": "https://ci.chromium.org/b/8869605364959030896",
    "utcnow_ts": "1599682189737290"
  }
}
[20:09:49.879] Task URL: https://ci.chromium.org/b/8869605364959030896
[20:09:49.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:2:0) after 1m0s
[20:10:08.157] Received PubSub notification, asking Buildbucket for the build status
[20:10:08.421] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:49.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:2:0)
[20:10:49.981] Timer tick, asking Buildbucket for the build status
[20:10:50.095] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:50.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:4:0) after 1m0s
[20:11:50.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:4:0)
[20:11:50.092] Timer tick, asking Buildbucket for the build status
[20:11:50.266] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:50.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:5:0) after 1m0s
[20:12:50.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:5:0)
[20:12:50.575] Timer tick, asking Buildbucket for the build status
[20:12:50.824] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:50.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:6:0) after 1m0s
[20:13:50.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:6:0)
[20:13:50.851] Timer tick, asking Buildbucket for the build status
[20:13:51.126] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:51.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:7:0) after 1m0s
[20:14:51.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:7:0)
[20:14:51.205] Timer tick, asking Buildbucket for the build status
[20:14:51.340] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:51.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:8:0) after 1m0s
[20:15:51.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:8:0)
[20:15:51.395] Timer tick, asking Buildbucket for the build status
[20:15:51.742] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:51.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:9:0) after 1m0s
[20:16:51.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:9:0)
[20:16:51.810] Timer tick, asking Buildbucket for the build status
[20:16:51.938] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:51.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:10:0) after 1m0s
[20:17:52.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:10:0)
[20:17:52.067] Timer tick, asking Buildbucket for the build status
[20:17:52.516] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:52.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:11:0) after 1m0s
[20:18:52.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:11:0)
[20:18:52.588] Timer tick, asking Buildbucket for the build status
[20:18:52.715] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:52.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:12:0) after 1m0s
[20:19:52.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:12:0)
[20:19:52.758] Timer tick, asking Buildbucket for the build status
[20:19:52.936] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:52.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:13:0) after 1m0s
[20:20:52.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:13:0)
[20:20:52.967] Timer tick, asking Buildbucket for the build status
[20:20:53.123] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:53.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:14:0) after 1m0s
[20:21:53.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:14:0)
[20:21:53.223] Timer tick, asking Buildbucket for the build status
[20:21:53.319] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:53.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:15:0) after 1m0s
[20:22:53.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:15:0)
[20:22:53.369] Timer tick, asking Buildbucket for the build status
[20:22:53.433] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:53.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:16:0) after 1m0s
[20:23:53.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:16:0)
[20:23:53.539] Timer tick, asking Buildbucket for the build status
[20:23:53.637] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:53.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:17:0) after 1m0s
[20:24:53.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:17:0)
[20:24:53.789] Timer tick, asking Buildbucket for the build status
[20:24:54.297] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:54.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:18:0) after 1m0s
[20:25:54.360] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:18:0)
[20:25:54.360] Timer tick, asking Buildbucket for the build status
[20:25:54.490] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:54.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:19:0) after 1m0s
[20:26:54.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:19:0)
[20:26:54.557] Timer tick, asking Buildbucket for the build status
[20:26:54.820] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:54.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:20:0) after 1m0s
[20:27:54.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:20:0)
[20:27:54.950] Timer tick, asking Buildbucket for the build status
[20:27:55.059] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:55.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:21:0) after 1m0s
[20:28:55.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:21:0)
[20:28:55.159] Timer tick, asking Buildbucket for the build status
[20:28:55.239] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:55.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:22:0) after 1m0s
[20:29:55.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:22:0)
[20:29:55.282] Timer tick, asking Buildbucket for the build status
[20:29:55.575] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:55.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:23:0) after 1m0s
[20:30:55.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:23:0)
[20:30:55.682] Timer tick, asking Buildbucket for the build status
[20:30:55.764] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:55.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:24:0) after 1m0s
[20:31:55.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:24:0)
[20:31:55.783] Timer tick, asking Buildbucket for the build status
[20:31:55.981] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:55.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:25:0) after 1m0s
[20:32:56.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:25:0)
[20:32:56.033] Timer tick, asking Buildbucket for the build status
[20:32:56.104] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:56.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:26:0) after 1m0s
[20:33:56.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:26:0)
[20:33:56.130] Timer tick, asking Buildbucket for the build status
[20:33:56.553] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:56.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:27:0) after 1m0s
[20:34:56.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:27:0)
[20:34:56.639] Timer tick, asking Buildbucket for the build status
[20:34:57.248] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:57.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:28:0) after 1m0s
[20:35:57.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:28:0)
[20:35:57.255] Timer tick, asking Buildbucket for the build status
[20:35:57.354] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:57.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:29:0) after 1m0s
[20:36:57.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:29:0)
[20:36:57.410] Timer tick, asking Buildbucket for the build status
[20:36:57.488] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:57.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:30:0) after 1m0s
[20:37:57.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:30:0)
[20:37:57.531] Timer tick, asking Buildbucket for the build status
[20:37:57.588] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:57.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:31:0) after 1m0s
[20:38:58.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:31:0)
[20:38:58.035] Timer tick, asking Buildbucket for the build status
[20:38:58.252] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:58.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:32:0) after 1m0s
[20:39:58.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:32:0)
[20:39:58.299] Timer tick, asking Buildbucket for the build status
[20:39:58.653] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:58.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:33:0) after 1m0s
[20:40:58.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:33:0)
[20:40:58.725] Timer tick, asking Buildbucket for the build status
[20:40:59.047] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:59.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:34:0) after 1m0s
[20:41:59.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:34:0)
[20:41:59.154] Timer tick, asking Buildbucket for the build status
[20:41:59.241] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:59.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:35:0) after 1m0s
[20:42:59.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:35:0)
[20:42:59.247] Timer tick, asking Buildbucket for the build status
[20:42:59.310] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:59.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:36:0) after 1m0s
[20:43:59.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:36:0)
[20:43:59.384] Timer tick, asking Buildbucket for the build status
[20:43:59.449] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:59.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:37:0) after 1m0s
[20:44:59.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:37:0)
[20:44:59.537] Timer tick, asking Buildbucket for the build status
[20:44:59.691] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:59.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:38:0) after 1m0s
[20:45:59.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:38:0)
[20:45:59.774] Timer tick, asking Buildbucket for the build status
[20:45:59.833] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:59.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:39:0) after 1m0s
[20:46:59.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:39:0)
[20:46:59.830] Timer tick, asking Buildbucket for the build status
[20:46:59.910] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:59.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:40:0) after 1m0s
[20:47:59.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:40:0)
[20:47:59.939] Timer tick, asking Buildbucket for the build status
[20:47:59.997] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:59.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:41:0) after 1m0s
[20:49:00.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:41:0)
[20:49:00.563] Timer tick, asking Buildbucket for the build status
[20:49:00.624] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:00.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:42:0) after 1m0s
[20:50:00.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:42:0)
[20:50:00.706] Timer tick, asking Buildbucket for the build status
[20:50:00.892] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:00.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:43:0) after 1m0s
[20:51:02.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:43:0)
[20:51:02.141] Timer tick, asking Buildbucket for the build status
[20:51:02.226] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:02.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:44:0) after 1m0s
[20:52:02.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:44:0)
[20:52:02.564] Timer tick, asking Buildbucket for the build status
[20:52:02.626] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:02.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:45:0) after 1m0s
[20:53:02.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:45:0)
[20:53:02.967] Timer tick, asking Buildbucket for the build status
[20:53:03.074] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:03.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:46:0) after 1m0s
[20:54:03.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:46:0)
[20:54:03.095] Timer tick, asking Buildbucket for the build status
[20:54:03.383] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:03.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:47:0) after 1m0s
[20:55:03.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:47:0)
[20:55:03.859] Timer tick, asking Buildbucket for the build status
[20:55:04.109] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:04.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:48:0) after 1m0s
[20:56:04.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:48:0)
[20:56:04.203] Timer tick, asking Buildbucket for the build status
[20:56:04.298] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:04.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:49:0) after 1m0s
[20:57:04.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:49:0)
[20:57:04.341] Timer tick, asking Buildbucket for the build status
[20:57:04.412] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:04.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:50:0) after 1m0s
[20:58:04.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:50:0)
[20:58:04.434] Timer tick, asking Buildbucket for the build status
[20:58:04.507] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:04.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:51:0) after 1m0s
[20:59:04.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:51:0)
[20:59:04.697] Timer tick, asking Buildbucket for the build status
[20:59:05.122] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:05.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:52:0) after 1m0s
[21:00:05.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:52:0)
[21:00:05.210] Timer tick, asking Buildbucket for the build status
[21:00:05.348] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:05.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:53:0) after 1m0s
[21:01:05.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:53:0)
[21:01:05.473] Timer tick, asking Buildbucket for the build status
[21:01:05.563] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:05.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:54:0) after 1m0s
[21:02:05.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:54:0)
[21:02:05.633] Timer tick, asking Buildbucket for the build status
[21:02:05.878] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:05.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:55:0) after 1m0s
[21:03:05.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:55:0)
[21:03:05.881] Timer tick, asking Buildbucket for the build status
[21:03:05.983] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:05.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:56:0) after 1m0s
[21:04:06.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:56:0)
[21:04:06.053] Timer tick, asking Buildbucket for the build status
[21:04:06.123] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:06.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:57:0) after 1m0s
[21:05:06.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:57:0)
[21:05:06.199] Timer tick, asking Buildbucket for the build status
[21:05:06.365] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:06.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:58:0) after 1m0s
[21:06:06.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:58:0)
[21:06:06.420] Timer tick, asking Buildbucket for the build status
[21:06:06.543] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:06.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:59:0) after 1m0s
[21:07:06.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:59:0)
[21:07:06.688] Timer tick, asking Buildbucket for the build status
[21:07:07.140] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:07.140] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:60:0) after 1m0s
[21:08:07.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:60:0)
[21:08:07.198] Timer tick, asking Buildbucket for the build status
[21:08:07.461] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:07.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:61:0) after 1m0s
[21:09:07.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:61:0)
[21:09:07.505] Timer tick, asking Buildbucket for the build status
[21:09:07.786] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:07.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:62:0) after 1m0s
[21:10:07.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:62:0)
[21:10:07.857] Timer tick, asking Buildbucket for the build status
[21:10:08.539] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:08.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:63:0) after 1m0s
[21:11:08.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:63:0)
[21:11:08.625] Timer tick, asking Buildbucket for the build status
[21:11:08.885] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:08.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:64:0) after 1m0s
[21:12:08.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:64:0)
[21:12:08.950] Timer tick, asking Buildbucket for the build status
[21:12:09.036] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:09.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:65:0) after 1m0s
[21:13:09.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:65:0)
[21:13:09.016] Timer tick, asking Buildbucket for the build status
[21:13:09.082] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:09.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:66:0) after 1m0s
[21:14:09.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:66:0)
[21:14:09.139] Timer tick, asking Buildbucket for the build status
[21:14:09.289] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:09.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:67:0) after 1m0s
[21:15:09.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:67:0)
[21:15:09.460] Timer tick, asking Buildbucket for the build status
[21:15:09.817] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:09.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:68:0) after 1m0s
[21:16:09.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:68:0)
[21:16:09.850] Timer tick, asking Buildbucket for the build status
[21:16:09.930] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:09.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:69:0) after 1m0s
[21:17:09.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:69:0)
[21:17:09.998] Timer tick, asking Buildbucket for the build status
[21:17:10.091] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:10.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:70:0) after 1m0s
[21:18:10.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:70:0)
[21:18:10.155] Timer tick, asking Buildbucket for the build status
[21:18:10.390] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:10.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:71:0) after 1m0s
[21:19:10.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:71:0)
[21:19:10.473] Timer tick, asking Buildbucket for the build status
[21:19:10.731] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:10.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:72:0) after 1m0s
[21:20:10.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:72:0)
[21:20:10.902] Timer tick, asking Buildbucket for the build status
[21:20:11.212] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:11.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:73:0) after 1m0s
[21:21:11.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:73:0)
[21:21:11.232] Timer tick, asking Buildbucket for the build status
[21:21:11.611] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:11.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:74:0) after 1m0s
[21:22:11.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:74:0)
[21:22:11.593] Timer tick, asking Buildbucket for the build status
[21:22:11.717] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:11.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:75:0) after 1m0s
[21:23:11.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:75:0)
[21:23:11.794] Timer tick, asking Buildbucket for the build status
[21:23:11.888] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:11.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:76:0) after 1m0s
[21:24:11.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:76:0)
[21:24:11.956] Timer tick, asking Buildbucket for the build status
[21:24:12.042] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:12.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:77:0) after 1m0s
[21:25:12.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:77:0)
[21:25:12.081] Timer tick, asking Buildbucket for the build status
[21:25:12.257] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:12.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:78:0) after 1m0s
[21:26:12.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:78:0)
[21:26:12.328] Timer tick, asking Buildbucket for the build status
[21:26:12.452] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:12.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:79:0) after 1m0s
[21:27:12.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:79:0)
[21:27:12.516] Timer tick, asking Buildbucket for the build status
[21:27:12.705] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:12.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:80:0) after 1m0s
[21:28:12.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:80:0)
[21:28:12.768] Timer tick, asking Buildbucket for the build status
[21:28:13.201] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:13.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:81:0) after 1m0s
[21:29:13.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:81:0)
[21:29:13.323] Timer tick, asking Buildbucket for the build status
[21:29:13.402] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:13.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:82:0) after 1m0s
[21:30:13.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:82:0)
[21:30:13.443] Timer tick, asking Buildbucket for the build status
[21:30:13.782] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:13.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:83:0) after 1m0s
[21:31:13.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:83:0)
[21:31:13.891] Timer tick, asking Buildbucket for the build status
[21:31:14.089] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:14.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:84:0) after 1m0s
[21:32:14.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:84:0)
[21:32:14.145] Timer tick, asking Buildbucket for the build status
[21:32:14.260] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:14.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:85:0) after 1m0s
[21:33:14.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:85:0)
[21:33:14.294] Timer tick, asking Buildbucket for the build status
[21:33:14.363] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:14.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:86:0) after 1m0s
[21:34:14.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:86:0)
[21:34:14.351] Timer tick, asking Buildbucket for the build status
[21:34:14.420] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:14.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:87:0) after 1m0s
[21:35:14.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:87:0)
[21:35:14.514] Timer tick, asking Buildbucket for the build status
[21:35:14.842] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:14.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:88:0) after 1m0s
[21:36:14.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:88:0)
[21:36:14.860] Timer tick, asking Buildbucket for the build status
[21:36:16.322] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:16.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:89:0) after 1m0s
[21:37:16.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:89:0)
[21:37:16.393] Timer tick, asking Buildbucket for the build status
[21:37:16.709] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:16.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:90:0) after 1m0s
[21:38:16.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:90:0)
[21:38:16.813] Timer tick, asking Buildbucket for the build status
[21:38:17.102] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:17.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:91:0) after 1m0s
[21:39:17.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:91:0)
[21:39:17.267] Timer tick, asking Buildbucket for the build status
[21:39:17.527] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:17.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:92:0) after 1m0s
[21:40:17.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:92:0)
[21:40:17.527] Timer tick, asking Buildbucket for the build status
[21:40:17.645] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:17.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:93:0) after 1m0s
[21:41:17.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:93:0)
[21:41:17.771] Timer tick, asking Buildbucket for the build status
[21:41:17.865] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:17.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:94:0) after 1m0s
[21:42:17.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:94:0)
[21:42:17.900] Timer tick, asking Buildbucket for the build status
[21:42:17.972] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:17.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:95:0) after 1m0s
[21:43:18.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:95:0)
[21:43:18.026] Timer tick, asking Buildbucket for the build status
[21:43:18.118] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:18.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:96:0) after 1m0s
[21:44:18.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:96:0)
[21:44:18.137] Timer tick, asking Buildbucket for the build status
[21:44:18.198] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:18.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:97:0) after 1m0s
[21:45:18.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:97:0)
[21:45:18.333] Timer tick, asking Buildbucket for the build status
[21:45:18.896] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:18.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:98:0) after 1m0s
[21:46:18.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:98:0)
[21:46:18.917] Timer tick, asking Buildbucket for the build status
[21:46:18.972] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:18.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:99:0) after 1m0s
[21:47:18.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:99:0)
[21:47:18.952] Timer tick, asking Buildbucket for the build status
[21:47:19.136] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:19.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:100:0) after 1m0s
[21:48:19.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:100:0)
[21:48:19.253] Timer tick, asking Buildbucket for the build status
[21:48:19.486] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:19.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:101:0) after 1m0s
[21:49:19.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:101:0)
[21:49:19.547] Timer tick, asking Buildbucket for the build status
[21:49:19.728] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:19.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:102:0) after 1m0s
[21:50:19.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:102:0)
[21:50:19.767] Timer tick, asking Buildbucket for the build status
[21:50:19.889] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:19.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:103:0) after 1m0s
[21:51:19.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:103:0)
[21:51:19.997] Timer tick, asking Buildbucket for the build status
[21:51:20.084] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:20.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:104:0) after 1m0s
[21:52:20.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:104:0)
[21:52:20.119] Timer tick, asking Buildbucket for the build status
[21:52:20.198] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:20.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:105:0) after 1m0s
[21:53:20.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:105:0)
[21:53:20.278] Timer tick, asking Buildbucket for the build status
[21:53:20.364] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:20.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:106:0) after 1m0s
[21:54:20.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:106:0)
[21:54:20.522] Timer tick, asking Buildbucket for the build status
[21:54:20.620] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:20.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:107:0) after 1m0s
[21:55:20.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:107:0)
[21:55:20.674] Timer tick, asking Buildbucket for the build status
[21:55:20.801] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:20.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:108:0) after 1m0s
[21:56:20.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:108:0)
[21:56:20.838] Timer tick, asking Buildbucket for the build status
[21:56:21.025] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:21.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:109:0) after 1m0s
[21:57:21.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:109:0)
[21:57:21.106] Timer tick, asking Buildbucket for the build status
[21:57:21.207] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:21.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:110:0) after 1m0s
[21:58:21.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:110:0)
[21:58:21.231] Timer tick, asking Buildbucket for the build status
[21:58:21.309] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:21.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:111:0) after 1m0s
[21:59:21.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:111:0)
[21:59:21.302] Timer tick, asking Buildbucket for the build status
[21:59:21.415] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:21.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:112:0) after 1m0s
[22:00:21.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:112:0)
[22:00:21.566] Timer tick, asking Buildbucket for the build status
[22:00:21.688] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:21.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:113:0) after 1m0s
[22:01:21.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:113:0)
[22:01:21.764] Timer tick, asking Buildbucket for the build status
[22:01:21.837] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:21.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:114:0) after 1m0s
[22:02:21.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:114:0)
[22:02:21.936] Timer tick, asking Buildbucket for the build status
[22:02:22.031] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:22.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:115:0) after 1m0s
[22:03:22.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:115:0)
[22:03:22.096] Timer tick, asking Buildbucket for the build status
[22:03:22.488] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:22.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:116:0) after 1m0s
[22:04:22.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:116:0)
[22:04:22.596] Timer tick, asking Buildbucket for the build status
[22:04:22.710] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:22.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:117:0) after 1m0s
[22:05:22.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:117:0)
[22:05:22.777] Timer tick, asking Buildbucket for the build status
[22:05:22.882] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:22.882] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:118:0) after 1m0s
[22:06:22.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:118:0)
[22:06:22.923] Timer tick, asking Buildbucket for the build status
[22:06:23.098] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:23.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:119:0) after 1m0s
[22:07:23.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:119:0)
[22:07:23.238] Timer tick, asking Buildbucket for the build status
[22:07:23.366] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:23.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:120:0) after 1m0s
[22:08:23.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:120:0)
[22:08:23.376] Timer tick, asking Buildbucket for the build status
[22:08:23.792] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:23.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:121:0) after 1m0s
[22:09:23.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:121:0)
[22:09:23.887] Timer tick, asking Buildbucket for the build status
[22:09:24.045] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:24.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:122:0) after 1m0s
[22:10:24.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:122:0)
[22:10:24.045] Timer tick, asking Buildbucket for the build status
[22:10:24.199] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:24.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:123:0) after 1m0s
[22:11:24.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:123:0)
[22:11:24.229] Timer tick, asking Buildbucket for the build status
[22:11:24.315] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:24.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:124:0) after 1m0s
[22:12:24.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:124:0)
[22:12:24.298] Timer tick, asking Buildbucket for the build status
[22:12:24.389] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:24.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:125:0) after 1m0s
[22:13:24.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:125:0)
[22:13:24.452] Timer tick, asking Buildbucket for the build status
[22:13:24.528] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:24.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:126:0) after 1m0s
[22:14:24.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:126:0)
[22:14:24.628] Timer tick, asking Buildbucket for the build status
[22:14:24.740] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:24.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:127:0) after 1m0s
[22:15:24.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:127:0)
[22:15:24.810] Timer tick, asking Buildbucket for the build status
[22:15:24.924] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:24.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:128:0) after 1m0s
[22:16:24.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:128:0)
[22:16:24.991] Timer tick, asking Buildbucket for the build status
[22:16:25.070] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:25.070] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:129:0) after 1m0s
[22:17:25.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:129:0)
[22:17:25.089] Timer tick, asking Buildbucket for the build status
[22:17:25.156] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:25.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:130:0) after 1m0s
[22:18:25.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:130:0)
[22:18:25.224] Timer tick, asking Buildbucket for the build status
[22:18:25.384] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:25.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:131:0) after 1m0s
[22:19:25.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:131:0)
[22:19:25.470] Timer tick, asking Buildbucket for the build status
[22:19:25.560] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:25.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:132:0) after 1m0s
[22:20:25.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:132:0)
[22:20:25.701] Timer tick, asking Buildbucket for the build status
[22:20:25.926] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:25.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:133:0) after 1m0s
[22:21:26.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:133:0)
[22:21:26.036] Timer tick, asking Buildbucket for the build status
[22:21:27.084] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:27.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:134:0) after 1m0s
[22:22:27.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:134:0)
[22:22:27.156] Timer tick, asking Buildbucket for the build status
[22:22:27.246] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:27.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:135:0) after 1m0s
[22:23:27.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:135:0)
[22:23:27.335] Timer tick, asking Buildbucket for the build status
[22:23:27.602] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:27.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:136:0) after 1m0s
[22:24:27.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:136:0)
[22:24:27.711] Timer tick, asking Buildbucket for the build status
[22:24:28.681] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:28.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:137:0) after 1m0s
[22:25:28.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:137:0)
[22:25:28.848] Timer tick, asking Buildbucket for the build status
[22:25:28.980] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:28.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:138:0) after 1m0s
[22:26:29.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:138:0)
[22:26:29.036] Timer tick, asking Buildbucket for the build status
[22:26:29.231] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:29.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:139:0) after 1m0s
[22:27:29.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:139:0)
[22:27:29.404] Timer tick, asking Buildbucket for the build status
[22:27:29.474] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:29.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:140:0) after 1m0s
[22:28:29.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:140:0)
[22:28:29.520] Timer tick, asking Buildbucket for the build status
[22:28:29.600] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:29.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:141:0) after 1m0s
[22:29:29.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:141:0)
[22:29:29.649] Timer tick, asking Buildbucket for the build status
[22:29:29.780] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:29.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:142:0) after 1m0s
[22:30:29.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:142:0)
[22:30:29.817] Timer tick, asking Buildbucket for the build status
[22:30:29.942] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:29.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:143:0) after 1m0s
[22:31:29.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:143:0)
[22:31:29.937] Timer tick, asking Buildbucket for the build status
[22:31:30.027] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:30.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:144:0) after 1m0s
[22:32:30.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:144:0)
[22:32:30.350] Timer tick, asking Buildbucket for the build status
[22:32:30.498] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:30.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:145:0) after 1m0s
[22:33:30.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:145:0)
[22:33:30.553] Timer tick, asking Buildbucket for the build status
[22:33:30.721] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:30.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:146:0) after 1m0s
[22:34:30.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:146:0)
[22:34:30.828] Timer tick, asking Buildbucket for the build status
[22:34:31.101] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:31.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:147:0) after 1m0s
[22:35:31.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:147:0)
[22:35:31.277] Timer tick, asking Buildbucket for the build status
[22:35:31.785] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:31.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:148:0) after 1m0s
[22:36:31.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:148:0)
[22:36:31.813] Timer tick, asking Buildbucket for the build status
[22:36:32.011] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:32.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:149:0) after 1m0s
[22:37:32.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:149:0)
[22:37:32.065] Timer tick, asking Buildbucket for the build status
[22:37:32.441] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:32.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:150:0) after 1m0s
[22:38:32.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:150:0)
[22:38:32.477] Timer tick, asking Buildbucket for the build status
[22:38:32.543] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:32.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:151:0) after 1m0s
[22:39:32.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:151:0)
[22:39:32.834] Timer tick, asking Buildbucket for the build status
[22:39:32.966] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:32.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:152:0) after 1m0s
[22:40:33.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:152:0)
[22:40:33.142] Timer tick, asking Buildbucket for the build status
[22:40:33.267] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:33.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:153:0) after 1m0s
[22:41:33.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:153:0)
[22:41:33.436] Timer tick, asking Buildbucket for the build status
[22:41:33.550] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:33.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:154:0) after 1m0s
[22:42:33.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:154:0)
[22:42:33.651] Timer tick, asking Buildbucket for the build status
[22:42:33.723] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:33.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:155:0) after 1m0s
[22:43:33.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:155:0)
[22:43:33.933] Timer tick, asking Buildbucket for the build status
[22:43:34.012] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:34.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:156:0) after 1m0s
[22:44:34.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:156:0)
[22:44:34.103] Timer tick, asking Buildbucket for the build status
[22:44:34.164] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:34.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:157:0) after 1m0s
[22:45:34.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:157:0)
[22:45:34.424] Timer tick, asking Buildbucket for the build status
[22:45:34.744] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:34.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:158:0) after 1m0s
[22:46:34.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:158:0)
[22:46:34.836] Timer tick, asking Buildbucket for the build status
[22:46:34.907] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:34.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:159:0) after 1m0s
[22:47:34.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:159:0)
[22:47:34.952] Timer tick, asking Buildbucket for the build status
[22:47:35.024] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:35.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:160:0) after 1m0s
[22:48:35.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:160:0)
[22:48:35.109] Timer tick, asking Buildbucket for the build status
[22:48:35.188] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:35.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:161:0) after 1m0s
[22:49:35.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:161:0)
[22:49:35.316] Timer tick, asking Buildbucket for the build status
[22:49:35.476] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:35.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:162:0) after 1m0s
[22:50:35.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:162:0)
[22:50:35.482] Timer tick, asking Buildbucket for the build status
[22:50:35.640] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:35.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:163:0) after 1m0s
[22:51:35.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:163:0)
[22:51:35.733] Timer tick, asking Buildbucket for the build status
[22:51:35.889] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:35.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:164:0) after 1m0s
[22:52:36.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:164:0)
[22:52:36.001] Timer tick, asking Buildbucket for the build status
[22:52:36.205] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:36.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:165:0) after 1m0s
[22:53:36.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:165:0)
[22:53:36.399] Timer tick, asking Buildbucket for the build status
[22:53:36.468] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:36.468] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:166:0) after 1m0s
[22:54:36.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:166:0)
[22:54:36.527] Timer tick, asking Buildbucket for the build status
[22:54:36.585] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:36.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:167:0) after 1m0s
[22:55:36.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:167:0)
[22:55:36.700] Timer tick, asking Buildbucket for the build status
[22:55:36.837] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:36.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:168:0) after 1m0s
[22:56:36.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:168:0)
[22:56:36.866] Timer tick, asking Buildbucket for the build status
[22:56:36.934] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:36.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:169:0) after 1m0s
[22:57:37.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:169:0)
[22:57:37.018] Timer tick, asking Buildbucket for the build status
[22:57:37.130] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:37.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:170:0) after 1m0s
[22:58:37.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:170:0)
[22:58:37.156] Timer tick, asking Buildbucket for the build status
[22:58:37.282] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:37.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:171:0) after 1m0s
[22:59:37.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:171:0)
[22:59:37.308] Timer tick, asking Buildbucket for the build status
[22:59:37.385] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:37.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:172:0) after 1m0s
[23:00:37.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:172:0)
[23:00:37.437] Timer tick, asking Buildbucket for the build status
[23:00:37.551] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:37.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:173:0) after 1m0s
[23:01:37.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:173:0)
[23:01:37.617] Timer tick, asking Buildbucket for the build status
[23:01:37.919] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:37.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:174:0) after 1m0s
[23:02:37.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:174:0)
[23:02:37.955] Timer tick, asking Buildbucket for the build status
[23:02:38.010] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:38.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:175:0) after 1m0s
[23:03:38.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:175:0)
[23:03:38.017] Timer tick, asking Buildbucket for the build status
[23:03:38.279] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:38.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:176:0) after 1m0s
[23:04:38.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:176:0)
[23:04:38.298] Timer tick, asking Buildbucket for the build status
[23:04:38.599] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:38.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:177:0) after 1m0s
[23:05:38.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:177:0)
[23:05:38.675] Timer tick, asking Buildbucket for the build status
[23:05:38.801] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:38.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:178:0) after 1m0s
[23:06:38.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:178:0)
[23:06:38.847] Timer tick, asking Buildbucket for the build status
[23:06:39.029] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:39.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:179:0) after 1m0s
[23:07:39.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:179:0)
[23:07:39.098] Timer tick, asking Buildbucket for the build status
[23:07:39.237] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:39.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:180:0) after 1m0s
[23:08:39.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:180:0)
[23:08:39.311] Timer tick, asking Buildbucket for the build status
[23:08:39.408] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:39.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:181:0) after 1m0s
[23:09:39.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:181:0)
[23:09:39.447] Timer tick, asking Buildbucket for the build status
[23:09:39.605] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:39.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:182:0) after 1m0s
[23:10:39.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:182:0)
[23:10:39.703] Timer tick, asking Buildbucket for the build status
[23:10:39.855] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:39.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:183:0) after 1m0s
[23:11:40.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:183:0)
[23:11:40.012] Timer tick, asking Buildbucket for the build status
[23:11:40.101] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:40.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:184:0) after 1m0s
[23:12:40.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:184:0)
[23:12:40.288] Timer tick, asking Buildbucket for the build status
[23:12:40.413] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:40.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:185:0) after 1m0s
[23:13:40.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:185:0)
[23:13:40.665] Timer tick, asking Buildbucket for the build status
[23:13:40.733] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:40.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:186:0) after 1m0s
[23:14:40.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:186:0)
[23:14:40.837] Timer tick, asking Buildbucket for the build status
[23:14:40.939] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:40.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:187:0) after 1m0s
[23:15:41.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:187:0)
[23:15:41.084] Timer tick, asking Buildbucket for the build status
[23:15:41.220] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:41.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:188:0) after 1m0s
[23:16:41.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:188:0)
[23:16:41.314] Timer tick, asking Buildbucket for the build status
[23:16:41.639] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:41.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:189:0) after 1m0s
[23:17:41.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:189:0)
[23:17:41.631] Timer tick, asking Buildbucket for the build status
[23:17:42.032] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:42.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:190:0) after 1m0s
[23:18:42.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:190:0)
[23:18:42.224] Timer tick, asking Buildbucket for the build status
[23:18:42.333] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:42.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:191:0) after 1m0s
[23:19:42.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:191:0)
[23:19:42.395] Timer tick, asking Buildbucket for the build status
[23:19:42.469] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:42.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:192:0) after 1m0s
[23:20:42.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:192:0)
[23:20:42.530] Timer tick, asking Buildbucket for the build status
[23:20:42.683] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:42.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:193:0) after 1m0s
[23:21:42.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:193:0)
[23:21:42.735] Timer tick, asking Buildbucket for the build status
[23:21:43.004] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:43.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:194:0) after 1m0s
[23:22:43.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:194:0)
[23:22:43.146] Timer tick, asking Buildbucket for the build status
[23:22:43.330] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:43.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:195:0) after 1m0s
[23:23:43.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:195:0)
[23:23:43.401] Timer tick, asking Buildbucket for the build status
[23:23:43.460] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:43.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:196:0) after 1m0s
[23:24:43.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:196:0)
[23:24:43.488] Timer tick, asking Buildbucket for the build status
[23:24:43.563] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:43.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:197:0) after 1m0s
[23:25:43.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:197:0)
[23:25:43.648] Timer tick, asking Buildbucket for the build status
[23:25:43.760] Build 8869605364959030896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:43.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035035427121589440:198:0) after 1m0s
[23:26:06.829] Received PubSub notification, asking Buildbucket for the build status
[23:26:06.887] Build 8869605364959030896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:26:06.887] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1599693966105423",
    "created_by": "project:infra",
    "created_ts": "1599682188987183",
    "id": "8869605364959030896",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.30\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"c3e051c3-739a-4eb1-a174-e693a655b62f\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.30\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_292036ca8cd0711903e829a3c5417e821d204af08fdef2e4b6d3affbee40eeb2_v2\", \"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-o83s\"], \"image\": [\"chrome-xenial-20090600-f98a2a06cf8\"], \"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\": [\"5513-ee65082\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1599682207421944",
    "status": "COMPLETED",
    "status_changed_ts": "1599693966498474",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9035035427121589440",
      "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/8869605364959030896/+/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:4e8d4ea3779cba10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1599693966511583",
    "url": "https://ci.chromium.org/b/8869605364959030896",
    "utcnow_ts": "1599693966880261"
  }
}
[23:26:06.887] Invocation finished in 3h16m19.345647189s with status SUCCEEDED