buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.infra.cron"
  builder: "publish_tarball_dispatcher"
>

• cron:v1:852 (7 years ago)

[06:37:02.192] New invocation is queued and will start shortly
[06:37:03.255] Starting the invocation (attempt 1)
[06:37:03.285] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:37:03.285] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:37:03.285] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9080656835411709680",
  "parameters_json": "{\"builder_name\":\"publish_tarball_dispatcher\",\"properties\":{}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:publish_tarball_dispatcher",
    "scheduler_invocation_id:9080656835411709680",
    "scheduler_job_id:infra/publish_tarball_dispatcher",
    "user_agent:luci-scheduler"
  ]
}
[06:37:03.626] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "created_by": "project:infra",
    "created_ts": "1556174223370734",
    "id": "8915226773513510912",
    "parameters_json": "{\"builder_name\": \"publish_tarball_dispatcher\", \"properties\": {}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1556174223531595",
    "tags": [
      "builder:publish_tarball_dispatcher",
      "scheduler_invocation_id:9080656835411709680",
      "scheduler_job_id:infra/publish_tarball_dispatcher",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8915226773513510912/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:recipe_name:publish_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1556174223531687",
    "url": "https://ci.chromium.org/b/8915226773513510912",
    "utcnow_ts": "1556174223618820"
  }
}
[06:37:03.626] Task URL: https://ci.chromium.org/b/8915226773513510912
[06:37:03.626] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:2:0) after 1m0s
[06:38:03.653] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:2:0)
[06:38:03.653] Timer tick, asking Buildbucket for the build status
[06:38:03.787] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:38:03.787] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:3:0) after 1m0s
[06:39:03.807] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:3:0)
[06:39:03.807] Timer tick, asking Buildbucket for the build status
[06:39:03.926] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:39:03.927] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:4:0) after 1m0s
[06:40:03.948] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:4:0)
[06:40:03.948] Timer tick, asking Buildbucket for the build status
[06:40:04.037] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:40:04.037] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:5:0) after 1m0s
[06:41:04.074] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:5:0)
[06:41:04.074] Timer tick, asking Buildbucket for the build status
[06:41:07.979] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:41:07.979] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:6:0) after 1m0s
[06:42:08.014] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:6:0)
[06:42:08.014] Timer tick, asking Buildbucket for the build status
[06:42:08.112] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:42:08.112] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:7:0) after 1m0s
[06:43:08.157] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:7:0)
[06:43:08.157] Timer tick, asking Buildbucket for the build status
[06:43:08.232] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:43:08.232] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:8:0) after 1m0s
[06:44:08.232] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:8:0)
[06:44:08.232] Timer tick, asking Buildbucket for the build status
[06:44:08.304] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:44:08.304] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:9:0) after 1m0s
[06:45:08.330] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:9:0)
[06:45:08.330] Timer tick, asking Buildbucket for the build status
[06:45:08.490] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:45:08.490] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:10:0) after 1m0s
[06:46:08.510] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:10:0)
[06:46:08.510] Timer tick, asking Buildbucket for the build status
[06:46:08.581] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:46:08.581] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:11:0) after 1m0s
[06:47:08.600] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:11:0)
[06:47:08.600] Timer tick, asking Buildbucket for the build status
[06:47:08.853] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:47:08.853] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:12:0) after 1m0s
[06:48:08.853] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:12:0)
[06:48:08.853] Timer tick, asking Buildbucket for the build status
[06:48:08.979] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:48:08.979] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:13:0) after 1m0s
[06:49:08.998] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:13:0)
[06:49:08.998] Timer tick, asking Buildbucket for the build status
[06:49:09.094] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:49:09.094] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:14:0) after 1m0s
[06:50:09.085] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:14:0)
[06:50:09.085] Timer tick, asking Buildbucket for the build status
[06:50:09.381] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:50:09.381] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:15:0) after 1m0s
[06:51:09.401] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:15:0)
[06:51:09.401] Timer tick, asking Buildbucket for the build status
[06:51:09.454] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:51:09.454] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:16:0) after 1m0s
[06:52:09.485] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:16:0)
[06:52:09.485] Timer tick, asking Buildbucket for the build status
[06:52:09.556] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:52:09.556] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:17:0) after 1m0s
[06:53:09.573] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:17:0)
[06:53:09.573] Timer tick, asking Buildbucket for the build status
[06:53:09.615] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:53:09.615] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:18:0) after 1m0s
[06:54:09.606] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:18:0)
[06:54:09.606] Timer tick, asking Buildbucket for the build status
[06:54:09.684] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:54:09.684] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:19:0) after 1m0s
[06:55:09.892] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:19:0)
[06:55:09.892] Timer tick, asking Buildbucket for the build status
[06:55:09.956] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:55:09.956] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:20:0) after 1m0s
[06:56:09.979] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:20:0)
[06:56:09.979] Timer tick, asking Buildbucket for the build status
[06:56:10.058] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:56:10.058] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:21:0) after 1m0s
[06:57:10.056] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:21:0)
[06:57:10.056] Timer tick, asking Buildbucket for the build status
[06:57:10.270] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:57:10.270] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:22:0) after 1m0s
[06:58:10.288] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:22:0)
[06:58:10.288] Timer tick, asking Buildbucket for the build status
[06:58:10.342] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:58:10.342] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:23:0) after 1m0s
[06:59:10.361] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:23:0)
[06:59:10.361] Timer tick, asking Buildbucket for the build status
[06:59:10.489] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:59:10.489] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:24:0) after 1m0s
[07:00:10.507] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:24:0)
[07:00:10.507] Timer tick, asking Buildbucket for the build status
[07:00:10.563] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:00:10.563] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:25:0) after 1m0s
[07:01:10.582] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:25:0)
[07:01:10.582] Timer tick, asking Buildbucket for the build status
[07:01:10.629] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:01:10.629] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:26:0) after 1m0s
[07:02:10.608] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:26:0)
[07:02:10.608] Timer tick, asking Buildbucket for the build status
[07:02:10.791] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:02:10.791] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:27:0) after 1m0s
[07:03:10.810] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:27:0)
[07:03:10.810] Timer tick, asking Buildbucket for the build status
[07:03:11.068] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:03:11.068] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:28:0) after 1m0s
[07:04:11.086] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:28:0)
[07:04:11.086] Timer tick, asking Buildbucket for the build status
[07:04:11.785] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:04:11.785] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:29:0) after 1m0s
[07:05:11.809] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:29:0)
[07:05:11.809] Timer tick, asking Buildbucket for the build status
[07:05:11.897] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:11.898] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:30:0) after 1m0s
[07:06:11.911] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:30:0)
[07:06:11.911] Timer tick, asking Buildbucket for the build status
[07:06:11.979] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:06:11.980] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:31:0) after 1m0s
[07:07:11.959] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:31:0)
[07:07:11.959] Timer tick, asking Buildbucket for the build status
[07:07:12.054] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:07:12.054] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:32:0) after 1m0s
[07:08:12.098] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:32:0)
[07:08:12.098] Timer tick, asking Buildbucket for the build status
[07:08:12.159] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:08:12.159] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:33:0) after 1m0s
[07:09:12.183] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:33:0)
[07:09:12.183] Timer tick, asking Buildbucket for the build status
[07:09:12.326] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:09:12.326] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:34:0) after 1m0s
[07:10:12.351] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:34:0)
[07:10:12.351] Timer tick, asking Buildbucket for the build status
[07:10:12.484] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:10:12.484] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:35:0) after 1m0s
[07:11:12.491] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:35:0)
[07:11:12.491] Timer tick, asking Buildbucket for the build status
[07:11:12.690] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:11:12.690] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:36:0) after 1m0s
[07:12:12.710] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:36:0)
[07:12:12.710] Timer tick, asking Buildbucket for the build status
[07:12:12.764] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:12:12.764] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:37:0) after 1m0s
[07:13:12.775] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:37:0)
[07:13:12.775] Timer tick, asking Buildbucket for the build status
[07:13:12.895] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:13:12.895] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:38:0) after 1m0s
[07:14:12.976] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:38:0)
[07:14:12.976] Timer tick, asking Buildbucket for the build status
[07:14:13.062] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:14:13.062] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:39:0) after 1m0s
[07:15:13.084] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:39:0)
[07:15:13.084] Timer tick, asking Buildbucket for the build status
[07:15:13.179] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:15:13.179] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:40:0) after 1m0s
[07:16:13.201] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:40:0)
[07:16:13.201] Timer tick, asking Buildbucket for the build status
[07:16:13.527] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:16:13.527] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:41:0) after 1m0s
[07:17:13.526] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:41:0)
[07:17:13.526] Timer tick, asking Buildbucket for the build status
[07:17:13.649] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:17:13.649] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:42:0) after 1m0s
[07:18:13.669] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:42:0)
[07:18:13.669] Timer tick, asking Buildbucket for the build status
[07:18:13.737] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:18:13.737] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:43:0) after 1m0s
[07:19:13.780] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:43:0)
[07:19:13.780] Timer tick, asking Buildbucket for the build status
[07:19:13.847] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:19:13.847] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:44:0) after 1m0s
[07:20:13.897] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:44:0)
[07:20:13.897] Timer tick, asking Buildbucket for the build status
[07:20:13.983] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:20:13.984] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:45:0) after 1m0s
[07:21:14.014] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:45:0)
[07:21:14.014] Timer tick, asking Buildbucket for the build status
[07:21:14.072] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:21:14.072] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:46:0) after 1m0s
[07:22:14.096] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:46:0)
[07:22:14.096] Timer tick, asking Buildbucket for the build status
[07:22:14.182] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:22:14.182] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:47:0) after 1m0s
[07:23:14.210] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:47:0)
[07:23:14.210] Timer tick, asking Buildbucket for the build status
[07:23:14.269] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:23:14.269] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:48:0) after 1m0s
[07:24:14.292] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:48:0)
[07:24:14.292] Timer tick, asking Buildbucket for the build status
[07:24:14.370] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:24:14.370] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:49:0) after 1m0s
[07:25:14.360] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:49:0)
[07:25:14.360] Timer tick, asking Buildbucket for the build status
[07:25:14.499] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:25:14.499] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:50:0) after 1m0s
[07:26:14.527] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:50:0)
[07:26:14.528] Timer tick, asking Buildbucket for the build status
[07:26:15.497] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:26:15.497] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:51:0) after 1m0s
[07:27:15.500] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:51:0)
[07:27:15.500] Timer tick, asking Buildbucket for the build status
[07:27:15.684] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:27:15.684] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:52:0) after 1m0s
[07:28:15.688] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:52:0)
[07:28:15.688] Timer tick, asking Buildbucket for the build status
[07:28:15.843] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:28:15.843] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:53:0) after 1m0s
[07:29:15.859] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:53:0)
[07:29:15.859] Timer tick, asking Buildbucket for the build status
[07:29:15.951] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:29:15.951] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:54:0) after 1m0s
[07:30:15.974] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:54:0)
[07:30:15.974] Timer tick, asking Buildbucket for the build status
[07:30:16.130] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:30:16.130] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:55:0) after 1m0s
[07:31:16.132] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:55:0)
[07:31:16.132] Timer tick, asking Buildbucket for the build status
[07:31:16.190] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:31:16.190] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:56:0) after 1m0s
[07:32:16.219] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:56:0)
[07:32:16.219] Timer tick, asking Buildbucket for the build status
[07:32:16.377] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:32:16.377] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:57:0) after 1m0s
[07:33:16.409] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:57:0)
[07:33:16.409] Timer tick, asking Buildbucket for the build status
[07:33:16.474] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:33:16.474] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:58:0) after 1m0s
[07:34:16.503] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:58:0)
[07:34:16.503] Timer tick, asking Buildbucket for the build status
[07:34:16.683] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:34:16.683] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:59:0) after 1m0s
[07:35:16.703] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:59:0)
[07:35:16.703] Timer tick, asking Buildbucket for the build status
[07:35:17.290] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:35:17.290] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:60:0) after 1m0s
[07:36:17.285] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:60:0)
[07:36:17.285] Timer tick, asking Buildbucket for the build status
[07:36:17.447] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:36:17.447] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:61:0) after 1m0s
[07:37:17.470] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:61:0)
[07:37:17.470] Timer tick, asking Buildbucket for the build status
[07:37:17.539] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:37:17.539] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:62:0) after 1m0s
[07:38:17.556] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:62:0)
[07:38:17.556] Timer tick, asking Buildbucket for the build status
[07:38:17.629] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:38:17.629] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:63:0) after 1m0s
[07:39:17.645] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:63:0)
[07:39:17.646] Timer tick, asking Buildbucket for the build status
[07:39:17.748] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:39:17.748] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:64:0) after 1m0s
[07:40:17.765] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:64:0)
[07:40:17.765] Timer tick, asking Buildbucket for the build status
[07:40:17.848] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:40:17.848] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:65:0) after 1m0s
[07:41:17.889] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:65:0)
[07:41:17.889] Timer tick, asking Buildbucket for the build status
[07:41:17.963] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:41:17.963] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:66:0) after 1m0s
[07:42:17.947] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:66:0)
[07:42:17.947] Timer tick, asking Buildbucket for the build status
[07:42:18.008] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:42:18.008] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:67:0) after 1m0s
[07:43:18.056] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:67:0)
[07:43:18.056] Timer tick, asking Buildbucket for the build status
[07:43:18.155] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:43:18.155] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:68:0) after 1m0s
[07:44:18.173] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:68:0)
[07:44:18.173] Timer tick, asking Buildbucket for the build status
[07:44:18.225] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:44:18.225] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:69:0) after 1m0s
[07:45:18.268] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:69:0)
[07:45:18.268] Timer tick, asking Buildbucket for the build status
[07:45:18.377] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:45:18.377] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:70:0) after 1m0s
[07:46:18.390] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:70:0)
[07:46:18.390] Timer tick, asking Buildbucket for the build status
[07:46:18.555] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:46:18.555] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:71:0) after 1m0s
[07:47:18.578] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:71:0)
[07:47:18.578] Timer tick, asking Buildbucket for the build status
[07:47:18.653] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:47:18.653] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:72:0) after 1m0s
[07:48:18.679] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:72:0)
[07:48:18.679] Timer tick, asking Buildbucket for the build status
[07:48:18.742] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:48:18.742] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:73:0) after 1m0s
[07:49:18.757] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:73:0)
[07:49:18.757] Timer tick, asking Buildbucket for the build status
[07:49:18.869] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:49:18.869] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:74:0) after 1m0s
[07:50:18.870] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:74:0)
[07:50:18.870] Timer tick, asking Buildbucket for the build status
[07:50:19.003] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:50:19.003] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:75:0) after 1m0s
[07:51:19.033] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:75:0)
[07:51:19.033] Timer tick, asking Buildbucket for the build status
[07:51:19.127] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:51:19.127] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:76:0) after 1m0s
[07:52:19.158] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:76:0)
[07:52:19.158] Timer tick, asking Buildbucket for the build status
[07:52:19.220] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:52:19.220] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:77:0) after 1m0s
[07:53:19.259] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:77:0)
[07:53:19.259] Timer tick, asking Buildbucket for the build status
[07:53:19.409] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:53:19.409] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:78:0) after 1m0s
[07:54:19.431] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:78:0)
[07:54:19.431] Timer tick, asking Buildbucket for the build status
[07:54:19.490] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:54:19.490] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:79:0) after 1m0s
[07:55:19.485] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:79:0)
[07:55:19.485] Timer tick, asking Buildbucket for the build status
[07:55:19.858] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:55:19.858] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:80:0) after 1m0s
[07:56:19.883] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:80:0)
[07:56:19.883] Timer tick, asking Buildbucket for the build status
[07:56:19.939] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:56:19.939] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:81:0) after 1m0s
[07:57:19.946] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:81:0)
[07:57:19.946] Timer tick, asking Buildbucket for the build status
[07:57:20.100] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:57:20.100] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:82:0) after 1m0s
[07:58:20.112] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:82:0)
[07:58:20.112] Timer tick, asking Buildbucket for the build status
[07:58:20.281] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:58:20.281] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:83:0) after 1m0s
[07:59:20.305] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:83:0)
[07:59:20.306] Timer tick, asking Buildbucket for the build status
[07:59:20.384] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:59:20.384] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:84:0) after 1m0s
[08:00:20.413] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:84:0)
[08:00:20.413] Timer tick, asking Buildbucket for the build status
[08:00:20.506] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:00:20.506] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:85:0) after 1m0s
[08:01:20.517] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:85:0)
[08:01:20.517] Timer tick, asking Buildbucket for the build status
[08:01:20.651] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:01:20.651] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:86:0) after 1m0s
[08:02:20.682] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:86:0)
[08:02:20.682] Timer tick, asking Buildbucket for the build status
[08:02:20.805] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:02:20.805] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:87:0) after 1m0s
[08:03:20.888] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:87:0)
[08:03:20.888] Timer tick, asking Buildbucket for the build status
[08:03:20.962] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:03:20.962] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:88:0) after 1m0s
[08:04:20.983] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:88:0)
[08:04:20.983] Timer tick, asking Buildbucket for the build status
[08:04:21.086] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:04:21.086] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:89:0) after 1m0s
[08:05:21.109] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:89:0)
[08:05:21.109] Timer tick, asking Buildbucket for the build status
[08:05:21.221] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:05:21.221] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:90:0) after 1m0s
[08:06:21.281] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:90:0)
[08:06:21.281] Timer tick, asking Buildbucket for the build status
[08:06:21.356] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:06:21.356] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:91:0) after 1m0s
[08:07:21.350] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:91:0)
[08:07:21.350] Timer tick, asking Buildbucket for the build status
[08:07:21.447] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:07:21.447] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:92:0) after 1m0s
[08:08:21.490] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:92:0)
[08:08:21.490] Timer tick, asking Buildbucket for the build status
[08:08:22.028] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:08:22.028] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:93:0) after 1m0s
[08:09:22.139] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:93:0)
[08:09:22.139] Timer tick, asking Buildbucket for the build status
[08:09:22.359] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:09:22.359] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:94:0) after 1m0s
[08:10:22.351] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:94:0)
[08:10:22.351] Timer tick, asking Buildbucket for the build status
[08:10:22.466] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:10:22.466] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:95:0) after 1m0s
[08:11:22.461] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:95:0)
[08:11:22.461] Timer tick, asking Buildbucket for the build status
[08:11:22.559] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:11:22.559] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:96:0) after 1m0s
[08:12:22.562] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:96:0)
[08:12:22.562] Timer tick, asking Buildbucket for the build status
[08:12:22.779] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:12:22.779] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:97:0) after 1m0s
[08:13:22.796] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:97:0)
[08:13:22.796] Timer tick, asking Buildbucket for the build status
[08:13:22.870] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:13:22.870] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:98:0) after 1m0s
[08:14:22.860] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:98:0)
[08:14:22.860] Timer tick, asking Buildbucket for the build status
[08:14:22.925] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:14:22.925] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:99:0) after 1m0s
[08:15:22.951] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:99:0)
[08:15:22.951] Timer tick, asking Buildbucket for the build status
[08:15:23.098] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:15:23.098] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:100:0) after 1m0s
[08:16:23.101] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:100:0)
[08:16:23.101] Timer tick, asking Buildbucket for the build status
[08:16:23.177] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:16:23.177] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:101:0) after 1m0s
[08:17:23.214] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:101:0)
[08:17:23.214] Timer tick, asking Buildbucket for the build status
[08:17:23.283] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:17:23.283] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:102:0) after 1m0s
[08:18:23.272] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:102:0)
[08:18:23.272] Timer tick, asking Buildbucket for the build status
[08:18:23.396] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:18:23.396] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:103:0) after 1m0s
[08:19:23.416] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:103:0)
[08:19:23.416] Timer tick, asking Buildbucket for the build status
[08:19:23.520] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:19:23.520] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:104:0) after 1m0s
[08:20:23.526] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:104:0)
[08:20:23.526] Timer tick, asking Buildbucket for the build status
[08:20:23.628] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:20:23.628] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:105:0) after 1m0s
[08:21:23.623] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:105:0)
[08:21:23.623] Timer tick, asking Buildbucket for the build status
[08:21:23.755] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:21:23.755] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:106:0) after 1m0s
[08:22:23.787] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:106:0)
[08:22:23.787] Timer tick, asking Buildbucket for the build status
[08:22:23.916] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:22:23.916] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:107:0) after 1m0s
[08:23:23.975] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:107:0)
[08:23:23.975] Timer tick, asking Buildbucket for the build status
[08:23:24.175] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:23:24.175] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:108:0) after 1m0s
[08:24:24.195] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:108:0)
[08:24:24.195] Timer tick, asking Buildbucket for the build status
[08:24:24.328] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:24:24.328] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:109:0) after 1m0s
[08:25:24.314] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:109:0)
[08:25:24.314] Timer tick, asking Buildbucket for the build status
[08:25:24.441] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:25:24.441] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:110:0) after 1m0s
[08:26:24.462] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:110:0)
[08:26:24.462] Timer tick, asking Buildbucket for the build status
[08:26:24.523] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:26:24.523] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:111:0) after 1m0s
[08:27:24.551] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:111:0)
[08:27:24.551] Timer tick, asking Buildbucket for the build status
[08:27:24.744] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:27:24.744] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:112:0) after 1m0s
[08:28:24.786] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:112:0)
[08:28:24.786] Timer tick, asking Buildbucket for the build status
[08:28:24.966] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:28:24.966] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:113:0) after 1m0s
[08:29:25.020] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:113:0)
[08:29:25.020] Timer tick, asking Buildbucket for the build status
[08:29:25.178] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:29:25.178] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:114:0) after 1m0s
[08:30:25.164] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:114:0)
[08:30:25.164] Timer tick, asking Buildbucket for the build status
[08:30:25.216] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:30:25.216] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:115:0) after 1m0s
[08:31:25.226] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:115:0)
[08:31:25.226] Timer tick, asking Buildbucket for the build status
[08:31:25.370] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:31:25.370] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:116:0) after 1m0s
[08:32:25.432] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:116:0)
[08:32:25.432] Timer tick, asking Buildbucket for the build status
[08:32:25.503] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:32:25.503] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:117:0) after 1m0s
[08:33:25.557] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:117:0)
[08:33:25.557] Timer tick, asking Buildbucket for the build status
[08:33:25.653] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:33:25.653] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:118:0) after 1m0s
[08:34:25.676] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:118:0)
[08:34:25.676] Timer tick, asking Buildbucket for the build status
[08:34:25.739] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:34:25.739] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:119:0) after 1m0s
[08:35:25.754] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:119:0)
[08:35:25.754] Timer tick, asking Buildbucket for the build status
[08:35:25.830] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:35:25.830] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:120:0) after 1m0s
[08:36:25.860] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:120:0)
[08:36:25.860] Timer tick, asking Buildbucket for the build status
[08:36:25.982] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:36:25.982] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:121:0) after 1m0s
[08:37:25.988] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:121:0)
[08:37:25.988] Timer tick, asking Buildbucket for the build status
[08:37:26.089] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:37:26.089] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:122:0) after 1m0s
[08:38:26.143] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:122:0)
[08:38:26.143] Timer tick, asking Buildbucket for the build status
[08:38:26.533] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:38:26.533] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:123:0) after 1m0s
[08:39:26.559] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:123:0)
[08:39:26.559] Timer tick, asking Buildbucket for the build status
[08:39:26.697] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:39:26.697] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:124:0) after 1m0s
[08:40:26.719] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:124:0)
[08:40:26.719] Timer tick, asking Buildbucket for the build status
[08:40:26.908] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:40:26.908] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:125:0) after 1m0s
[08:41:26.928] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:125:0)
[08:41:26.928] Timer tick, asking Buildbucket for the build status
[08:41:27.025] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:41:27.025] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:126:0) after 1m0s
[08:42:27.058] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:126:0)
[08:42:27.058] Timer tick, asking Buildbucket for the build status
[08:42:27.110] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:42:27.110] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:127:0) after 1m0s
[08:43:27.264] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:127:0)
[08:43:27.264] Timer tick, asking Buildbucket for the build status
[08:43:27.475] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:43:27.475] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:128:0) after 1m0s
[08:44:27.452] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:128:0)
[08:44:27.452] Timer tick, asking Buildbucket for the build status
[08:44:27.591] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:44:27.591] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:129:0) after 1m0s
[08:45:27.624] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:129:0)
[08:45:27.624] Timer tick, asking Buildbucket for the build status
[08:45:27.700] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:45:27.700] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:130:0) after 1m0s
[08:46:27.698] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:130:0)
[08:46:27.698] Timer tick, asking Buildbucket for the build status
[08:46:27.809] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:46:27.809] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:131:0) after 1m0s
[08:47:27.819] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:131:0)
[08:47:27.819] Timer tick, asking Buildbucket for the build status
[08:47:27.920] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:47:27.920] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:132:0) after 1m0s
[08:48:27.906] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:132:0)
[08:48:27.906] Timer tick, asking Buildbucket for the build status
[08:48:27.974] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:48:27.974] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:133:0) after 1m0s
[08:49:27.974] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:133:0)
[08:49:27.974] Timer tick, asking Buildbucket for the build status
[08:49:28.054] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:49:28.054] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:134:0) after 1m0s
[08:50:28.078] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:134:0)
[08:50:28.078] Timer tick, asking Buildbucket for the build status
[08:50:28.141] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:50:28.141] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:135:0) after 1m0s
[08:51:28.205] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:135:0)
[08:51:28.205] Timer tick, asking Buildbucket for the build status
[08:51:28.279] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:51:28.279] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:136:0) after 1m0s
[08:52:28.289] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:136:0)
[08:52:28.289] Timer tick, asking Buildbucket for the build status
[08:52:28.791] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:52:28.791] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:137:0) after 1m0s
[08:53:28.820] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:137:0)
[08:53:28.820] Timer tick, asking Buildbucket for the build status
[08:53:28.972] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:53:28.972] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:138:0) after 1m0s
[08:54:28.959] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:138:0)
[08:54:28.959] Timer tick, asking Buildbucket for the build status
[08:54:29.025] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:54:29.025] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:139:0) after 1m0s
[08:55:29.051] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:139:0)
[08:55:29.051] Timer tick, asking Buildbucket for the build status
[08:55:29.133] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:55:29.133] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:140:0) after 1m0s
[08:56:29.128] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:140:0)
[08:56:29.128] Timer tick, asking Buildbucket for the build status
[08:56:29.347] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:56:29.348] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:141:0) after 1m0s
[08:57:29.370] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:141:0)
[08:57:29.370] Timer tick, asking Buildbucket for the build status
[08:57:29.460] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:57:29.460] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:142:0) after 1m0s
[08:58:29.493] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:142:0)
[08:58:29.493] Timer tick, asking Buildbucket for the build status
[08:58:29.569] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:58:29.569] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:143:0) after 1m0s
[08:59:29.593] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:143:0)
[08:59:29.593] Timer tick, asking Buildbucket for the build status
[08:59:29.662] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:59:29.662] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:144:0) after 1m0s
[09:00:29.683] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:144:0)
[09:00:29.683] Timer tick, asking Buildbucket for the build status
[09:00:29.889] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:00:29.889] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:145:0) after 1m0s
[09:01:29.928] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:145:0)
[09:01:29.928] Timer tick, asking Buildbucket for the build status
[09:01:30.156] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:01:30.156] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:146:0) after 1m0s
[09:02:30.166] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:146:0)
[09:02:30.166] Timer tick, asking Buildbucket for the build status
[09:02:30.218] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:02:30.218] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:147:0) after 1m0s
[09:03:30.211] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:147:0)
[09:03:30.211] Timer tick, asking Buildbucket for the build status
[09:03:30.299] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:03:30.299] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:148:0) after 1m0s
[09:04:30.324] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:148:0)
[09:04:30.324] Timer tick, asking Buildbucket for the build status
[09:04:30.400] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:04:30.400] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:149:0) after 1m0s
[09:05:30.427] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:149:0)
[09:05:30.427] Timer tick, asking Buildbucket for the build status
[09:05:30.587] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:05:30.587] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:150:0) after 1m0s
[09:06:30.608] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:150:0)
[09:06:30.608] Timer tick, asking Buildbucket for the build status
[09:06:30.729] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:06:30.729] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:151:0) after 1m0s
[09:07:30.750] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:151:0)
[09:07:30.750] Timer tick, asking Buildbucket for the build status
[09:07:30.839] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:07:30.839] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:152:0) after 1m0s
[09:08:30.856] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:152:0)
[09:08:30.856] Timer tick, asking Buildbucket for the build status
[09:08:30.935] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:08:30.935] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:153:0) after 1m0s
[09:09:30.963] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:153:0)
[09:09:30.963] Timer tick, asking Buildbucket for the build status
[09:09:31.042] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:09:31.042] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:154:0) after 1m0s
[09:10:31.066] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:154:0)
[09:10:31.066] Timer tick, asking Buildbucket for the build status
[09:10:31.197] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:10:31.197] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:155:0) after 1m0s
[09:11:31.233] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:155:0)
[09:11:31.233] Timer tick, asking Buildbucket for the build status
[09:11:31.317] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:11:31.317] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:156:0) after 1m0s
[09:12:31.337] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:156:0)
[09:12:31.337] Timer tick, asking Buildbucket for the build status
[09:12:31.481] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:12:31.481] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:157:0) after 1m0s
[09:13:31.503] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:157:0)
[09:13:31.503] Timer tick, asking Buildbucket for the build status
[09:13:31.616] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:13:31.616] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:158:0) after 1m0s
[09:14:31.638] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:158:0)
[09:14:31.638] Timer tick, asking Buildbucket for the build status
[09:14:31.742] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:14:31.742] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:159:0) after 1m0s
[09:15:31.773] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:159:0)
[09:15:31.773] Timer tick, asking Buildbucket for the build status
[09:15:31.932] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:15:31.932] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:160:0) after 1m0s
[09:16:31.957] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:160:0)
[09:16:31.957] Timer tick, asking Buildbucket for the build status
[09:16:32.013] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:16:32.013] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:161:0) after 1m0s
[09:17:32.041] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:161:0)
[09:17:32.041] Timer tick, asking Buildbucket for the build status
[09:17:32.152] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:17:32.152] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:162:0) after 1m0s
[09:18:32.153] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:162:0)
[09:18:32.153] Timer tick, asking Buildbucket for the build status
[09:18:32.281] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:18:32.281] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:163:0) after 1m0s
[09:19:32.307] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:163:0)
[09:19:32.307] Timer tick, asking Buildbucket for the build status
[09:19:32.587] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:19:32.587] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:164:0) after 1m0s
[09:20:32.610] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:164:0)
[09:20:32.610] Timer tick, asking Buildbucket for the build status
[09:20:32.890] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:20:32.890] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:165:0) after 1m0s
[09:21:32.914] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:165:0)
[09:21:32.914] Timer tick, asking Buildbucket for the build status
[09:21:33.156] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:21:33.156] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:166:0) after 1m0s
[09:22:33.181] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:166:0)
[09:22:33.181] Timer tick, asking Buildbucket for the build status
[09:22:33.239] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:22:33.239] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:167:0) after 1m0s
[09:23:33.241] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:167:0)
[09:23:33.241] Timer tick, asking Buildbucket for the build status
[09:23:33.315] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:23:33.315] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:168:0) after 1m0s
[09:24:33.323] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:168:0)
[09:24:33.323] Timer tick, asking Buildbucket for the build status
[09:24:33.405] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:24:33.405] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:169:0) after 1m0s
[09:25:33.413] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:169:0)
[09:25:33.413] Timer tick, asking Buildbucket for the build status
[09:25:33.648] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:25:33.648] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:170:0) after 1m0s
[09:26:33.673] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:170:0)
[09:26:33.673] Timer tick, asking Buildbucket for the build status
[09:26:33.762] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:26:33.762] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:171:0) after 1m0s
[09:27:33.778] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:171:0)
[09:27:33.778] Timer tick, asking Buildbucket for the build status
[09:27:33.958] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:27:33.958] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:172:0) after 1m0s
[09:28:33.938] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:172:0)
[09:28:33.938] Timer tick, asking Buildbucket for the build status
[09:28:34.428] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:28:34.428] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:173:0) after 1m0s
[09:29:34.427] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:173:0)
[09:29:34.427] Timer tick, asking Buildbucket for the build status
[09:29:34.483] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:29:34.483] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:174:0) after 1m0s
[09:30:34.491] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:174:0)
[09:30:34.491] Timer tick, asking Buildbucket for the build status
[09:30:34.752] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:30:34.752] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:175:0) after 1m0s
[09:31:34.755] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:175:0)
[09:31:34.755] Timer tick, asking Buildbucket for the build status
[09:31:34.823] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:31:34.824] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:176:0) after 1m0s
[09:32:34.846] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:176:0)
[09:32:34.846] Timer tick, asking Buildbucket for the build status
[09:32:34.943] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:32:34.943] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:177:0) after 1m0s
[09:33:35.010] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:177:0)
[09:33:35.010] Timer tick, asking Buildbucket for the build status
[09:33:35.066] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:33:35.066] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:178:0) after 1m0s
[09:34:35.093] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:178:0)
[09:34:35.093] Timer tick, asking Buildbucket for the build status
[09:34:35.414] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:34:35.414] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:179:0) after 1m0s
[09:35:35.433] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:179:0)
[09:35:35.434] Timer tick, asking Buildbucket for the build status
[09:35:35.514] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:35:35.514] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:180:0) after 1m0s
[09:36:35.544] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:180:0)
[09:36:35.544] Timer tick, asking Buildbucket for the build status
[09:36:35.656] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:36:35.656] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:181:0) after 1m0s
[09:37:35.679] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:181:0)
[09:37:35.679] Timer tick, asking Buildbucket for the build status
[09:37:35.780] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:37:35.780] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:182:0) after 1m0s
[09:38:35.771] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:182:0)
[09:38:35.771] Timer tick, asking Buildbucket for the build status
[09:38:35.882] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:38:35.882] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:183:0) after 1m0s
[09:39:35.871] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:183:0)
[09:39:35.871] Timer tick, asking Buildbucket for the build status
[09:39:35.925] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:39:35.925] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:184:0) after 1m0s
[09:40:35.914] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:184:0)
[09:40:35.914] Timer tick, asking Buildbucket for the build status
[09:40:36.088] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:40:36.088] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:185:0) after 1m0s
[09:41:36.111] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:185:0)
[09:41:36.111] Timer tick, asking Buildbucket for the build status
[09:41:36.157] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:41:36.157] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:186:0) after 1m0s
[09:42:36.144] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:186:0)
[09:42:36.144] Timer tick, asking Buildbucket for the build status
[09:42:36.235] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:42:36.235] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:187:0) after 1m0s
[09:43:36.268] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:187:0)
[09:43:36.268] Timer tick, asking Buildbucket for the build status
[09:43:36.441] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:36.441] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:188:0) after 1m0s
[09:44:36.477] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:188:0)
[09:44:36.477] Timer tick, asking Buildbucket for the build status
[09:44:36.544] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:44:36.544] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:189:0) after 1m0s
[09:45:36.524] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:189:0)
[09:45:36.525] Timer tick, asking Buildbucket for the build status
[09:45:36.593] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:45:36.593] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:190:0) after 1m0s
[09:46:36.616] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:190:0)
[09:46:36.616] Timer tick, asking Buildbucket for the build status
[09:46:36.712] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:46:36.712] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:191:0) after 1m0s
[09:47:36.741] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:191:0)
[09:47:36.741] Timer tick, asking Buildbucket for the build status
[09:47:36.801] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:47:36.801] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:192:0) after 1m0s
[09:48:36.841] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:192:0)
[09:48:36.841] Timer tick, asking Buildbucket for the build status
[09:48:36.967] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:48:36.967] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:193:0) after 1m0s
[09:49:36.988] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:193:0)
[09:49:36.988] Timer tick, asking Buildbucket for the build status
[09:49:37.141] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:49:37.141] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:194:0) after 1m0s
[09:50:37.163] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:194:0)
[09:50:37.163] Timer tick, asking Buildbucket for the build status
[09:50:37.257] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:50:37.257] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:195:0) after 1m0s
[09:51:37.281] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:195:0)
[09:51:37.281] Timer tick, asking Buildbucket for the build status
[09:51:37.350] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:51:37.351] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:196:0) after 1m0s
[09:52:37.379] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:196:0)
[09:52:37.379] Timer tick, asking Buildbucket for the build status
[09:52:37.650] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:52:37.650] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:197:0) after 1m0s
[09:53:37.674] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:197:0)
[09:53:37.674] Timer tick, asking Buildbucket for the build status
[09:53:37.824] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:53:37.824] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:198:0) after 1m0s
[09:54:37.872] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:198:0)
[09:54:37.872] Timer tick, asking Buildbucket for the build status
[09:54:38.058] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:54:38.058] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:199:0) after 1m0s
[09:55:38.055] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:199:0)
[09:55:38.055] Timer tick, asking Buildbucket for the build status
[09:55:38.139] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:55:38.139] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:200:0) after 1m0s
[09:56:38.118] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:200:0)
[09:56:38.118] Timer tick, asking Buildbucket for the build status
[09:56:38.202] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:56:38.202] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:201:0) after 1m0s
[09:57:38.226] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:201:0)
[09:57:38.226] Timer tick, asking Buildbucket for the build status
[09:57:38.316] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:57:38.316] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:202:0) after 1m0s
[09:58:38.356] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:202:0)
[09:58:38.356] Timer tick, asking Buildbucket for the build status
[09:58:38.436] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:58:38.436] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:203:0) after 1m0s
[09:59:38.461] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:203:0)
[09:59:38.461] Timer tick, asking Buildbucket for the build status
[09:59:38.536] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:38.536] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:204:0) after 1m0s
[10:00:38.567] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:204:0)
[10:00:38.567] Timer tick, asking Buildbucket for the build status
[10:00:38.999] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:00:38.999] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:205:0) after 1m0s
[10:01:39.023] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:205:0)
[10:01:39.023] Timer tick, asking Buildbucket for the build status
[10:01:39.166] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:01:39.166] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:206:0) after 1m0s
[10:02:39.160] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:206:0)
[10:02:39.160] Timer tick, asking Buildbucket for the build status
[10:02:39.254] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:39.254] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:207:0) after 1m0s
[10:03:39.250] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:207:0)
[10:03:39.250] Timer tick, asking Buildbucket for the build status
[10:03:39.308] Build 8915226773513510912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:03:39.308] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:208:0) after 1m0s
[10:04:31.397] Received PubSub notification, asking Buildbucket for the build status
[10:04:31.446] Build 8915226773513510912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:39.287] Handling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:208:0)
[10:04:39.287] Timer tick, asking Buildbucket for the build status
[10:04:39.410] Build 8915226773513510912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:39.410] Scheduling timer "check-buildbucket-build-status" (infra/publish_tarball_dispatcher:9080656835411709680:210:0) after 1m0s
[10:05:04.900] Received PubSub notification, asking Buildbucket for the build status
[10:05:04.946] Build 8915226773513510912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:05:04.946] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "completed_ts": "1556186704216792",
    "created_by": "project:infra",
    "created_ts": "1556174223370734",
    "id": "8915226773513510912",
    "parameters_json": "{\"builder_name\": \"publish_tarball_dispatcher\", \"properties\": {}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"publish-tarball-0-jks6\", \"buildername\": \"publish_tarball_dispatcher\", \"path_config\": \"generic\", \"recipe\": \"publish_tarball\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"publish_tarball\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"publish-tarball-0-jks6\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4274-a0a5f8c\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1556186670586091",
    "status": "COMPLETED",
    "status_changed_ts": "1556186704645486",
    "tags": [
      "builder:publish_tarball_dispatcher",
      "scheduler_invocation_id:9080656835411709680",
      "scheduler_job_id:infra/publish_tarball_dispatcher",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8915226773513510912/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:publish_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_task_id:446c07c1ebbc7510",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1556186704651219",
    "url": "https://ci.chromium.org/b/8915226773513510912",
    "utcnow_ts": "1556186704936109"
  }
}
[10:05:04.946] Invocation finished in 3h28m2.770070848s with status SUCCEEDED