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

• parent_buildername:publish_tarball
• user_agent:recipe

[06:24:26.120] New invocation is queued and will start shortly
[06:24:26.120] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[06:24:28.428] Starting the invocation (attempt 1)
[06:24:28.506] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:24:28.506] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:24:28.506] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9042606902330318112",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4147.51\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"7127de0f-349e-4610-95c5-8b9ab971d5d1\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4147.51\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9042606902330318112",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[06:24:28.981] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:infra",
    "created_ts": "1592461468603407",
    "id": "8877176839056170256",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4147.51\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"7127de0f-349e-4610-95c5-8b9ab971d5d1\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4147.51\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1592461468809679",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9042606902330318112",
      "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/8877176839056170256/+/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": "1592461468809807",
    "url": "https://ci.chromium.org/b/8877176839056170256",
    "utcnow_ts": "1592461468966077"
  }
}
[06:24:28.981] Task URL: https://ci.chromium.org/b/8877176839056170256
[06:24:28.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:2:0) after 1m0s
[06:25:23.945] Received PubSub notification, asking Buildbucket for the build status
[06:25:24.226] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:29.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:2:0)
[06:25:29.167] Timer tick, asking Buildbucket for the build status
[06:25:29.456] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:29.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:4:0) after 1m0s
[06:26:29.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:4:0)
[06:26:29.908] Timer tick, asking Buildbucket for the build status
[06:26:30.666] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:30.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:5:0) after 1m0s
[06:27:30.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:5:0)
[06:27:30.902] Timer tick, asking Buildbucket for the build status
[06:27:31.146] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:31.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:6:0) after 1m0s
[06:28:31.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:6:0)
[06:28:31.274] Timer tick, asking Buildbucket for the build status
[06:28:32.695] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:32.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:7:0) after 1m0s
[06:29:32.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:7:0)
[06:29:32.722] Timer tick, asking Buildbucket for the build status
[06:29:32.808] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:32.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:8:0) after 1m0s
[06:30:32.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:8:0)
[06:30:32.837] Timer tick, asking Buildbucket for the build status
[06:30:33.203] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:33.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:9:0) after 1m0s
[06:31:33.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:9:0)
[06:31:33.264] Timer tick, asking Buildbucket for the build status
[06:31:33.442] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:33.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:10:0) after 1m0s
[06:32:33.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:10:0)
[06:32:33.455] Timer tick, asking Buildbucket for the build status
[06:32:33.602] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:33.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:11:0) after 1m0s
[06:33:33.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:11:0)
[06:33:33.626] Timer tick, asking Buildbucket for the build status
[06:33:34.141] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:34.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:12:0) after 1m0s
[06:34:34.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:12:0)
[06:34:34.161] Timer tick, asking Buildbucket for the build status
[06:34:34.312] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:34.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:13:0) after 1m0s
[06:35:34.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:13:0)
[06:35:34.354] Timer tick, asking Buildbucket for the build status
[06:35:34.505] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:34.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:14:0) after 1m0s
[06:36:34.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:14:0)
[06:36:34.511] Timer tick, asking Buildbucket for the build status
[06:36:35.157] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:35.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:15:0) after 1m0s
[06:37:35.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:15:0)
[06:37:35.156] Timer tick, asking Buildbucket for the build status
[06:37:35.388] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:35.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:16:0) after 1m0s
[06:38:35.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:16:0)
[06:38:35.442] Timer tick, asking Buildbucket for the build status
[06:38:36.862] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:36.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:17:0) after 1m0s
[06:39:36.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:17:0)
[06:39:36.875] Timer tick, asking Buildbucket for the build status
[06:39:37.103] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:37.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:18:0) after 1m0s
[06:40:37.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:18:0)
[06:40:37.124] Timer tick, asking Buildbucket for the build status
[06:40:37.781] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:37.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:19:0) after 1m0s
[06:41:37.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:19:0)
[06:41:37.808] Timer tick, asking Buildbucket for the build status
[06:41:37.972] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:37.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:20:0) after 1m0s
[06:42:37.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:20:0)
[06:42:37.992] Timer tick, asking Buildbucket for the build status
[06:42:38.431] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:38.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:21:0) after 1m0s
[06:43:38.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:21:0)
[06:43:38.548] Timer tick, asking Buildbucket for the build status
[06:43:39.063] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:39.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:22:0) after 1m0s
[06:44:39.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:22:0)
[06:44:39.092] Timer tick, asking Buildbucket for the build status
[06:44:39.347] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:39.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:23:0) after 1m0s
[06:45:39.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:23:0)
[06:45:39.371] Timer tick, asking Buildbucket for the build status
[06:45:39.628] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:39.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:24:0) after 1m0s
[06:46:39.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:24:0)
[06:46:39.636] Timer tick, asking Buildbucket for the build status
[06:46:39.777] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:39.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:25:0) after 1m0s
[06:47:39.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:25:0)
[06:47:39.799] Timer tick, asking Buildbucket for the build status
[06:47:40.147] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:40.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:26:0) after 1m0s
[06:48:40.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:26:0)
[06:48:40.247] Timer tick, asking Buildbucket for the build status
[06:48:42.552] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:42.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:27:0) after 1m0s
[06:49:42.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:27:0)
[06:49:42.554] Timer tick, asking Buildbucket for the build status
[06:49:42.855] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:42.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:28:0) after 1m0s
[06:50:42.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:28:0)
[06:50:42.878] Timer tick, asking Buildbucket for the build status
[06:50:43.365] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:43.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:29:0) after 1m0s
[06:51:43.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:29:0)
[06:51:43.451] Timer tick, asking Buildbucket for the build status
[06:51:44.005] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:44.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:30:0) after 1m0s
[06:52:44.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:30:0)
[06:52:44.102] Timer tick, asking Buildbucket for the build status
[06:52:44.449] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:44.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:31:0) after 1m0s
[06:53:44.491] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:31:0)
[06:53:44.491] Timer tick, asking Buildbucket for the build status
[06:53:50.686] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:50.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:32:0) after 1m0s
[06:54:52.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:32:0)
[06:54:52.312] Timer tick, asking Buildbucket for the build status
[06:54:52.460] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:52.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:33:0) after 1m0s
[06:55:52.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:33:0)
[06:55:52.707] Timer tick, asking Buildbucket for the build status
[06:55:53.175] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:53.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:34:0) after 1m0s
[06:56:53.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:34:0)
[06:56:53.319] Timer tick, asking Buildbucket for the build status
[06:56:53.536] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:53.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:35:0) after 1m0s
[06:57:53.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:35:0)
[06:57:53.735] Timer tick, asking Buildbucket for the build status
[06:57:54.905] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:54.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:36:0) after 1m0s
[06:58:55.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:36:0)
[06:58:55.029] Timer tick, asking Buildbucket for the build status
[06:58:56.584] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:56.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:37:0) after 1m0s
[06:59:56.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:37:0)
[06:59:56.640] Timer tick, asking Buildbucket for the build status
[06:59:56.772] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:56.772] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:38:0) after 1m0s
[07:00:57.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:38:0)
[07:00:57.041] Timer tick, asking Buildbucket for the build status
[07:00:57.209] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:57.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:39:0) after 1m0s
[07:01:57.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:39:0)
[07:01:57.416] Timer tick, asking Buildbucket for the build status
[07:01:57.907] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:57.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:40:0) after 1m0s
[07:02:57.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:40:0)
[07:02:57.938] Timer tick, asking Buildbucket for the build status
[07:02:58.162] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:58.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:41:0) after 1m0s
[07:03:58.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:41:0)
[07:03:58.222] Timer tick, asking Buildbucket for the build status
[07:03:58.586] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:58.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:42:0) after 1m0s
[07:04:58.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:42:0)
[07:04:58.662] Timer tick, asking Buildbucket for the build status
[07:04:59.148] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:59.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:43:0) after 1m0s
[07:05:59.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:43:0)
[07:05:59.794] Timer tick, asking Buildbucket for the build status
[07:06:00.259] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:00.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:44:0) after 1m0s
[07:07:00.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:44:0)
[07:07:00.859] Timer tick, asking Buildbucket for the build status
[07:07:01.282] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:01.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:45:0) after 1m0s
[07:08:01.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:45:0)
[07:08:01.804] Timer tick, asking Buildbucket for the build status
[07:08:02.056] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:02.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:46:0) after 1m0s
[07:09:02.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:46:0)
[07:09:02.208] Timer tick, asking Buildbucket for the build status
[07:09:03.445] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:03.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:47:0) after 1m0s
[07:10:03.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:47:0)
[07:10:03.502] Timer tick, asking Buildbucket for the build status
[07:10:04.048] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:04.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:48:0) after 1m0s
[07:11:04.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:48:0)
[07:11:04.569] Timer tick, asking Buildbucket for the build status
[07:11:04.781] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:04.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:49:0) after 1m0s
[07:12:04.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:49:0)
[07:12:04.971] Timer tick, asking Buildbucket for the build status
[07:12:05.139] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:05.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:50:0) after 1m0s
[07:13:05.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:50:0)
[07:13:05.204] Timer tick, asking Buildbucket for the build status
[07:13:05.531] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:05.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:51:0) after 1m0s
[07:14:05.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:51:0)
[07:14:05.607] Timer tick, asking Buildbucket for the build status
[07:14:05.954] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:05.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:52:0) after 1m0s
[07:15:06.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:52:0)
[07:15:06.020] Timer tick, asking Buildbucket for the build status
[07:15:06.135] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:06.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:53:0) after 1m0s
[07:16:06.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:53:0)
[07:16:06.182] Timer tick, asking Buildbucket for the build status
[07:16:07.101] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:07.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:54:0) after 1m0s
[07:17:07.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:54:0)
[07:17:07.181] Timer tick, asking Buildbucket for the build status
[07:17:08.160] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:08.160] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:55:0) after 1m0s
[07:18:08.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:55:0)
[07:18:08.245] Timer tick, asking Buildbucket for the build status
[07:18:08.460] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:08.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:56:0) after 1m0s
[07:19:08.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:56:0)
[07:19:08.708] Timer tick, asking Buildbucket for the build status
[07:19:08.936] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:08.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:57:0) after 1m0s
[07:20:09.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:57:0)
[07:20:09.380] Timer tick, asking Buildbucket for the build status
[07:20:09.530] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:09.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:58:0) after 1m0s
[07:21:09.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:58:0)
[07:21:09.577] Timer tick, asking Buildbucket for the build status
[07:21:09.802] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:09.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:59:0) after 1m0s
[07:22:09.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:59:0)
[07:22:09.910] Timer tick, asking Buildbucket for the build status
[07:22:10.150] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:10.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:60:0) after 1m0s
[07:23:10.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:60:0)
[07:23:10.262] Timer tick, asking Buildbucket for the build status
[07:23:10.436] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:10.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:61:0) after 1m0s
[07:24:10.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:61:0)
[07:24:10.506] Timer tick, asking Buildbucket for the build status
[07:24:11.635] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:11.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:62:0) after 1m0s
[07:25:11.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:62:0)
[07:25:11.636] Timer tick, asking Buildbucket for the build status
[07:25:11.769] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:11.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:63:0) after 1m0s
[07:26:11.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:63:0)
[07:26:11.752] Timer tick, asking Buildbucket for the build status
[07:26:11.948] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:11.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:64:0) after 1m0s
[07:27:12.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:64:0)
[07:27:12.011] Timer tick, asking Buildbucket for the build status
[07:27:12.240] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:12.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:65:0) after 1m0s
[07:28:12.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:65:0)
[07:28:12.297] Timer tick, asking Buildbucket for the build status
[07:28:12.482] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:12.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:66:0) after 1m0s
[07:29:12.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:66:0)
[07:29:12.561] Timer tick, asking Buildbucket for the build status
[07:29:12.767] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:12.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:67:0) after 1m0s
[07:30:12.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:67:0)
[07:30:12.831] Timer tick, asking Buildbucket for the build status
[07:30:13.194] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:13.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:68:0) after 1m0s
[07:31:13.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:68:0)
[07:31:13.246] Timer tick, asking Buildbucket for the build status
[07:31:13.542] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:13.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:69:0) after 1m0s
[07:32:13.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:69:0)
[07:32:13.896] Timer tick, asking Buildbucket for the build status
[07:32:14.198] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:14.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:70:0) after 1m0s
[07:33:14.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:70:0)
[07:33:14.570] Timer tick, asking Buildbucket for the build status
[07:33:15.174] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:15.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:71:0) after 1m0s
[07:34:15.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:71:0)
[07:34:15.209] Timer tick, asking Buildbucket for the build status
[07:34:15.390] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:15.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:72:0) after 1m0s
[07:35:15.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:72:0)
[07:35:15.678] Timer tick, asking Buildbucket for the build status
[07:35:16.318] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:16.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:73:0) after 1m0s
[07:36:16.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:73:0)
[07:36:16.437] Timer tick, asking Buildbucket for the build status
[07:36:16.620] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:16.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:74:0) after 1m0s
[07:37:16.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:74:0)
[07:37:16.759] Timer tick, asking Buildbucket for the build status
[07:37:16.912] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:16.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:75:0) after 1m0s
[07:38:17.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:75:0)
[07:38:17.003] Timer tick, asking Buildbucket for the build status
[07:38:17.247] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:17.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:76:0) after 1m0s
[07:39:17.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:76:0)
[07:39:17.305] Timer tick, asking Buildbucket for the build status
[07:39:17.549] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:17.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:77:0) after 1m0s
[07:40:17.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:77:0)
[07:40:17.639] Timer tick, asking Buildbucket for the build status
[07:40:17.880] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:17.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:78:0) after 1m0s
[07:41:18.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:78:0)
[07:41:18.256] Timer tick, asking Buildbucket for the build status
[07:41:18.395] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:18.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:79:0) after 1m0s
[07:42:18.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:79:0)
[07:42:18.518] Timer tick, asking Buildbucket for the build status
[07:42:18.850] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:18.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:80:0) after 1m0s
[07:43:18.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:80:0)
[07:43:18.925] Timer tick, asking Buildbucket for the build status
[07:43:19.091] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:19.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:81:0) after 1m0s
[07:44:19.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:81:0)
[07:44:19.127] Timer tick, asking Buildbucket for the build status
[07:44:19.258] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:19.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:82:0) after 1m0s
[07:45:19.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:82:0)
[07:45:19.309] Timer tick, asking Buildbucket for the build status
[07:45:19.683] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:19.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:83:0) after 1m0s
[07:46:19.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:83:0)
[07:46:19.812] Timer tick, asking Buildbucket for the build status
[07:46:20.196] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:20.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:84:0) after 1m0s
[07:47:20.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:84:0)
[07:47:20.236] Timer tick, asking Buildbucket for the build status
[07:47:20.656] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:20.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:85:0) after 1m0s
[07:48:20.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:85:0)
[07:48:20.726] Timer tick, asking Buildbucket for the build status
[07:48:21.268] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:21.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:86:0) after 1m0s
[07:49:21.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:86:0)
[07:49:21.458] Timer tick, asking Buildbucket for the build status
[07:49:21.674] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:21.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:87:0) after 1m0s
[07:50:21.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:87:0)
[07:50:21.711] Timer tick, asking Buildbucket for the build status
[07:50:22.272] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:22.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:88:0) after 1m0s
[07:51:22.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:88:0)
[07:51:22.344] Timer tick, asking Buildbucket for the build status
[07:51:22.535] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:22.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:89:0) after 1m0s
[07:52:22.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:89:0)
[07:52:22.652] Timer tick, asking Buildbucket for the build status
[07:52:22.819] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:22.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:90:0) after 1m0s
[07:53:22.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:90:0)
[07:53:22.856] Timer tick, asking Buildbucket for the build status
[07:53:23.128] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:23.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:91:0) after 1m0s
[07:54:23.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:91:0)
[07:54:23.213] Timer tick, asking Buildbucket for the build status
[07:54:23.629] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:23.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:92:0) after 1m0s
[07:55:23.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:92:0)
[07:55:23.893] Timer tick, asking Buildbucket for the build status
[07:55:24.472] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:24.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:93:0) after 1m0s
[07:56:24.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:93:0)
[07:56:24.572] Timer tick, asking Buildbucket for the build status
[07:56:24.858] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:24.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:94:0) after 1m0s
[07:57:24.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:94:0)
[07:57:24.943] Timer tick, asking Buildbucket for the build status
[07:57:25.111] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:25.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:95:0) after 1m0s
[07:58:25.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:95:0)
[07:58:25.160] Timer tick, asking Buildbucket for the build status
[07:58:26.511] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:26.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:96:0) after 1m0s
[07:59:26.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:96:0)
[07:59:26.516] Timer tick, asking Buildbucket for the build status
[07:59:26.618] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:26.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:97:0) after 1m0s
[08:00:26.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:97:0)
[08:00:26.665] Timer tick, asking Buildbucket for the build status
[08:00:26.831] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:26.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:98:0) after 1m0s
[08:01:27.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:98:0)
[08:01:27.144] Timer tick, asking Buildbucket for the build status
[08:01:28.139] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:28.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:99:0) after 1m0s
[08:02:28.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:99:0)
[08:02:28.224] Timer tick, asking Buildbucket for the build status
[08:02:28.600] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:28.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:100:0) after 1m0s
[08:03:28.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:100:0)
[08:03:28.702] Timer tick, asking Buildbucket for the build status
[08:03:28.830] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:28.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:101:0) after 1m0s
[08:04:28.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:101:0)
[08:04:28.910] Timer tick, asking Buildbucket for the build status
[08:04:29.277] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:29.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:102:0) after 1m0s
[08:05:29.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:102:0)
[08:05:29.344] Timer tick, asking Buildbucket for the build status
[08:05:29.648] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:29.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:103:0) after 1m0s
[08:06:29.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:103:0)
[08:06:29.715] Timer tick, asking Buildbucket for the build status
[08:06:30.308] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:30.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:104:0) after 1m0s
[08:07:30.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:104:0)
[08:07:30.485] Timer tick, asking Buildbucket for the build status
[08:07:30.744] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:30.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:105:0) after 1m0s
[08:08:30.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:105:0)
[08:08:30.790] Timer tick, asking Buildbucket for the build status
[08:08:31.061] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:31.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:106:0) after 1m0s
[08:09:31.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:106:0)
[08:09:31.233] Timer tick, asking Buildbucket for the build status
[08:09:31.577] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:31.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:107:0) after 1m0s
[08:10:31.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:107:0)
[08:10:31.756] Timer tick, asking Buildbucket for the build status
[08:10:31.968] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:31.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:108:0) after 1m0s
[08:11:32.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:108:0)
[08:11:32.124] Timer tick, asking Buildbucket for the build status
[08:11:32.232] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:32.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:109:0) after 1m0s
[08:12:32.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:109:0)
[08:12:32.317] Timer tick, asking Buildbucket for the build status
[08:12:32.424] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:32.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:110:0) after 1m0s
[08:13:32.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:110:0)
[08:13:32.449] Timer tick, asking Buildbucket for the build status
[08:13:32.634] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:32.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:111:0) after 1m0s
[08:14:33.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:111:0)
[08:14:33.097] Timer tick, asking Buildbucket for the build status
[08:14:33.311] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:33.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:112:0) after 1m0s
[08:15:33.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:112:0)
[08:15:33.512] Timer tick, asking Buildbucket for the build status
[08:15:33.717] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:33.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:113:0) after 1m0s
[08:16:33.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:113:0)
[08:16:33.909] Timer tick, asking Buildbucket for the build status
[08:16:34.113] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:34.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:114:0) after 1m0s
[08:17:34.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:114:0)
[08:17:34.117] Timer tick, asking Buildbucket for the build status
[08:17:34.365] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:34.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:115:0) after 1m0s
[08:18:34.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:115:0)
[08:18:34.460] Timer tick, asking Buildbucket for the build status
[08:18:34.701] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:34.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:116:0) after 1m0s
[08:19:34.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:116:0)
[08:19:34.843] Timer tick, asking Buildbucket for the build status
[08:19:35.001] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:35.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:117:0) after 1m0s
[08:20:35.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:117:0)
[08:20:35.242] Timer tick, asking Buildbucket for the build status
[08:20:35.392] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:35.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:118:0) after 1m0s
[08:21:35.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:118:0)
[08:21:35.570] Timer tick, asking Buildbucket for the build status
[08:21:35.943] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:35.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:119:0) after 1m0s
[08:22:36.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:119:0)
[08:22:36.089] Timer tick, asking Buildbucket for the build status
[08:22:36.664] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:36.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:120:0) after 1m0s
[08:23:37.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:120:0)
[08:23:37.568] Timer tick, asking Buildbucket for the build status
[08:23:37.976] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:37.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:121:0) after 1m0s
[08:24:38.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:121:0)
[08:24:38.045] Timer tick, asking Buildbucket for the build status
[08:24:38.320] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:38.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:122:0) after 1m0s
[08:25:38.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:122:0)
[08:25:38.448] Timer tick, asking Buildbucket for the build status
[08:25:38.699] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:38.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:123:0) after 1m0s
[08:26:38.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:123:0)
[08:26:38.731] Timer tick, asking Buildbucket for the build status
[08:26:39.759] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:39.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:124:0) after 1m0s
[08:27:39.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:124:0)
[08:27:39.783] Timer tick, asking Buildbucket for the build status
[08:27:40.902] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:40.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:125:0) after 1m0s
[08:28:40.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:125:0)
[08:28:40.931] Timer tick, asking Buildbucket for the build status
[08:28:41.151] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:41.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:126:0) after 1m0s
[08:29:41.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:126:0)
[08:29:41.204] Timer tick, asking Buildbucket for the build status
[08:29:41.406] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:41.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:127:0) after 1m0s
[08:30:41.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:127:0)
[08:30:41.487] Timer tick, asking Buildbucket for the build status
[08:30:41.606] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:41.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:128:0) after 1m0s
[08:31:41.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:128:0)
[08:31:41.696] Timer tick, asking Buildbucket for the build status
[08:31:41.909] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:41.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:129:0) after 1m0s
[08:32:42.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:129:0)
[08:32:42.013] Timer tick, asking Buildbucket for the build status
[08:32:42.226] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:42.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:130:0) after 1m0s
[08:33:42.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:130:0)
[08:33:42.346] Timer tick, asking Buildbucket for the build status
[08:33:45.315] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:45.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:131:0) after 1m0s
[08:34:45.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:131:0)
[08:34:45.349] Timer tick, asking Buildbucket for the build status
[08:34:45.718] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:45.718] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:132:0) after 1m0s
[08:35:45.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:132:0)
[08:35:45.809] Timer tick, asking Buildbucket for the build status
[08:35:46.141] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:46.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:133:0) after 1m0s
[08:36:46.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:133:0)
[08:36:46.225] Timer tick, asking Buildbucket for the build status
[08:36:46.463] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:46.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:134:0) after 1m0s
[08:37:46.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:134:0)
[08:37:46.555] Timer tick, asking Buildbucket for the build status
[08:37:47.044] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:47.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:135:0) after 1m0s
[08:38:47.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:135:0)
[08:38:47.117] Timer tick, asking Buildbucket for the build status
[08:38:48.734] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:48.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:136:0) after 1m0s
[08:39:48.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:136:0)
[08:39:48.798] Timer tick, asking Buildbucket for the build status
[08:39:48.938] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:48.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:137:0) after 1m0s
[08:40:48.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:137:0)
[08:40:48.987] Timer tick, asking Buildbucket for the build status
[08:40:49.370] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:49.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:138:0) after 1m0s
[08:41:49.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:138:0)
[08:41:49.441] Timer tick, asking Buildbucket for the build status
[08:41:49.715] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:49.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:139:0) after 1m0s
[08:42:49.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:139:0)
[08:42:49.738] Timer tick, asking Buildbucket for the build status
[08:42:50.049] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:50.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:140:0) after 1m0s
[08:43:50.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:140:0)
[08:43:50.091] Timer tick, asking Buildbucket for the build status
[08:43:50.460] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:50.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:141:0) after 1m0s
[08:44:50.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:141:0)
[08:44:50.500] Timer tick, asking Buildbucket for the build status
[08:44:50.667] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:50.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:142:0) after 1m0s
[08:45:50.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:142:0)
[08:45:50.708] Timer tick, asking Buildbucket for the build status
[08:45:51.245] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:51.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:143:0) after 1m0s
[08:46:51.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:143:0)
[08:46:51.274] Timer tick, asking Buildbucket for the build status
[08:46:51.525] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:51.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:144:0) after 1m0s
[08:47:51.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:144:0)
[08:47:51.560] Timer tick, asking Buildbucket for the build status
[08:47:51.846] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:51.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:145:0) after 1m0s
[08:48:51.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:145:0)
[08:48:51.841] Timer tick, asking Buildbucket for the build status
[08:48:52.963] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:52.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:146:0) after 1m0s
[08:49:53.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:146:0)
[08:49:53.032] Timer tick, asking Buildbucket for the build status
[08:49:53.377] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:53.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:147:0) after 1m0s
[08:50:53.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:147:0)
[08:50:53.380] Timer tick, asking Buildbucket for the build status
[08:50:53.823] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:53.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:148:0) after 1m0s
[08:51:53.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:148:0)
[08:51:53.951] Timer tick, asking Buildbucket for the build status
[08:51:54.219] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:54.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:149:0) after 1m0s
[08:52:54.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:149:0)
[08:52:54.402] Timer tick, asking Buildbucket for the build status
[08:52:54.612] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:54.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:150:0) after 1m0s
[08:53:54.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:150:0)
[08:53:54.664] Timer tick, asking Buildbucket for the build status
[08:53:58.164] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:58.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:151:0) after 1m0s
[08:54:58.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:151:0)
[08:54:58.181] Timer tick, asking Buildbucket for the build status
[08:54:58.359] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:58.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:152:0) after 1m0s
[08:55:58.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:152:0)
[08:55:58.420] Timer tick, asking Buildbucket for the build status
[08:55:58.607] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:58.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:153:0) after 1m0s
[08:56:58.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:153:0)
[08:56:58.706] Timer tick, asking Buildbucket for the build status
[08:56:59.123] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:59.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:154:0) after 1m0s
[08:57:59.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:154:0)
[08:57:59.199] Timer tick, asking Buildbucket for the build status
[08:57:59.437] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:59.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:155:0) after 1m0s
[08:58:59.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:155:0)
[08:58:59.520] Timer tick, asking Buildbucket for the build status
[08:58:59.785] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:59.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:156:0) after 1m0s
[08:59:59.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:156:0)
[08:59:59.866] Timer tick, asking Buildbucket for the build status
[09:00:00.276] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:00.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:157:0) after 1m0s
[09:01:00.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:157:0)
[09:01:00.320] Timer tick, asking Buildbucket for the build status
[09:01:00.549] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:00.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:158:0) after 1m0s
[09:02:00.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:158:0)
[09:02:00.626] Timer tick, asking Buildbucket for the build status
[09:02:01.514] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:01.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:159:0) after 1m0s
[09:03:01.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:159:0)
[09:03:01.542] Timer tick, asking Buildbucket for the build status
[09:03:02.106] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:02.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:160:0) after 1m0s
[09:04:02.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:160:0)
[09:04:02.159] Timer tick, asking Buildbucket for the build status
[09:04:02.372] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:02.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:161:0) after 1m0s
[09:05:02.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:161:0)
[09:05:02.561] Timer tick, asking Buildbucket for the build status
[09:05:02.717] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:02.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:162:0) after 1m0s
[09:06:02.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:162:0)
[09:06:02.819] Timer tick, asking Buildbucket for the build status
[09:06:03.210] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:03.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:163:0) after 1m0s
[09:07:03.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:163:0)
[09:07:03.268] Timer tick, asking Buildbucket for the build status
[09:07:03.570] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:03.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:164:0) after 1m0s
[09:08:03.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:164:0)
[09:08:03.671] Timer tick, asking Buildbucket for the build status
[09:08:04.049] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:04.050] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:165:0) after 1m0s
[09:09:04.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:165:0)
[09:09:04.356] Timer tick, asking Buildbucket for the build status
[09:09:06.814] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:06.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:166:0) after 1m0s
[09:10:07.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:166:0)
[09:10:07.187] Timer tick, asking Buildbucket for the build status
[09:10:07.315] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:07.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:167:0) after 1m0s
[09:11:07.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:167:0)
[09:11:07.517] Timer tick, asking Buildbucket for the build status
[09:11:07.682] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:07.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:168:0) after 1m0s
[09:12:07.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:168:0)
[09:12:07.910] Timer tick, asking Buildbucket for the build status
[09:12:08.344] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:08.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:169:0) after 1m0s
[09:13:08.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:169:0)
[09:13:08.513] Timer tick, asking Buildbucket for the build status
[09:13:08.904] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:08.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:170:0) after 1m0s
[09:14:08.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:170:0)
[09:14:08.898] Timer tick, asking Buildbucket for the build status
[09:14:09.015] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:09.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:171:0) after 1m0s
[09:15:09.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:171:0)
[09:15:09.078] Timer tick, asking Buildbucket for the build status
[09:15:09.252] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:09.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:172:0) after 1m0s
[09:16:09.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:172:0)
[09:16:09.289] Timer tick, asking Buildbucket for the build status
[09:16:09.506] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:09.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:173:0) after 1m0s
[09:17:09.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:173:0)
[09:17:09.552] Timer tick, asking Buildbucket for the build status
[09:17:10.016] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:10.016] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:174:0) after 1m0s
[09:18:10.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:174:0)
[09:18:10.132] Timer tick, asking Buildbucket for the build status
[09:18:10.294] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:10.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:175:0) after 1m0s
[09:19:10.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:175:0)
[09:19:10.484] Timer tick, asking Buildbucket for the build status
[09:19:10.705] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:10.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:176:0) after 1m0s
[09:20:10.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:176:0)
[09:20:10.918] Timer tick, asking Buildbucket for the build status
[09:20:11.103] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:11.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:177:0) after 1m0s
[09:21:11.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:177:0)
[09:21:11.214] Timer tick, asking Buildbucket for the build status
[09:21:11.467] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:11.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:178:0) after 1m0s
[09:22:11.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:178:0)
[09:22:11.597] Timer tick, asking Buildbucket for the build status
[09:22:11.928] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:11.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:179:0) after 1m0s
[09:23:12.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:179:0)
[09:23:12.096] Timer tick, asking Buildbucket for the build status
[09:23:12.339] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:12.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:180:0) after 1m0s
[09:24:12.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:180:0)
[09:24:12.392] Timer tick, asking Buildbucket for the build status
[09:24:12.531] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:12.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:181:0) after 1m0s
[09:25:12.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:181:0)
[09:25:12.565] Timer tick, asking Buildbucket for the build status
[09:25:13.161] Build 8877176839056170256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:13.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042606902330318112:182:0) after 1m0s
[09:25:24.563] Received PubSub notification, asking Buildbucket for the build status
[09:25:24.981] Build 8877176839056170256: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:25:24.981] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1592472323672611",
    "created_by": "project:infra",
    "created_ts": "1592461468603407",
    "id": "8877176839056170256",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4147.51\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"7127de0f-349e-4610-95c5-8b9ab971d5d1\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4147.51\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-fiyq\"], \"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\": [\"5215-5d67f2e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1592461522029192",
    "status": "COMPLETED",
    "status_changed_ts": "1592472324079140",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9042606902330318112",
      "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/8877176839056170256/+/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:4cdeeb2deba65810",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1592472324093410",
    "url": "https://ci.chromium.org/b/8877176839056170256",
    "utcnow_ts": "1592472324953232"
  }
}
[09:25:24.981] Invocation finished in 3h0m58.884835848s with status SUCCEEDED