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

• publish_tarball/0 (5 years ago by chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com)

{
  "version": "83.0.4103.34"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[20:25:07.079] New invocation is queued and will start shortly
[20:25:07.079] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[20:25:08.176] Starting the invocation (attempt 1)
[20:25:08.262] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:25:08.262] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:25:08.262] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9047083859463661936",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"83.0.4103.34\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"3bc50b9a-4401-447a-a17f-86e35ab4d51d\",\"title\":\"publish_tarball/0\"}]},\"version\":\"83.0.4103.34\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9047083859463661936",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[20:25:12.071] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1588191908409710",
    "id": "8881653797406758480",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4103.34\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3bc50b9a-4401-447a-a17f-86e35ab4d51d\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4103.34\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1588191911629197",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9047083859463661936",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8881653797406758480/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:recipe_name:build_from_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_task_id:",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1588191911629443",
    "url": "https://ci.chromium.org/b/8881653797406758480",
    "utcnow_ts": "1588191912053761"
  }
}
[20:25:12.072] Task URL: https://ci.chromium.org/b/8881653797406758480
[20:25:12.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:2:0) after 1m0s
[20:26:12.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:2:0)
[20:26:12.147] Timer tick, asking Buildbucket for the build status
[20:26:12.677] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:12.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:3:0) after 1m0s
[20:27:12.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:3:0)
[20:27:12.723] Timer tick, asking Buildbucket for the build status
[20:27:12.853] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:12.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:4:0) after 1m0s
[20:28:12.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:4:0)
[20:28:12.874] Timer tick, asking Buildbucket for the build status
[20:28:13.092] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:13.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:5:0) after 1m0s
[20:29:13.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:5:0)
[20:29:13.145] Timer tick, asking Buildbucket for the build status
[20:29:13.443] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:13.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:6:0) after 1m0s
[20:30:13.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:6:0)
[20:30:13.468] Timer tick, asking Buildbucket for the build status
[20:30:13.635] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:13.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:7:0) after 1m0s
[20:31:13.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:7:0)
[20:31:13.713] Timer tick, asking Buildbucket for the build status
[20:31:13.848] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:13.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:8:0) after 1m0s
[20:32:13.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:8:0)
[20:32:13.869] Timer tick, asking Buildbucket for the build status
[20:32:15.653] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:15.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:9:0) after 1m0s
[20:33:15.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:9:0)
[20:33:15.690] Timer tick, asking Buildbucket for the build status
[20:33:15.831] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:15.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:10:0) after 1m0s
[20:34:15.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:10:0)
[20:34:15.833] Timer tick, asking Buildbucket for the build status
[20:34:15.937] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:15.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:11:0) after 1m0s
[20:35:16.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:11:0)
[20:35:16.049] Timer tick, asking Buildbucket for the build status
[20:35:17.007] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:35:17.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:12:0) after 1m0s
[20:36:17.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:12:0)
[20:36:17.014] Timer tick, asking Buildbucket for the build status
[20:36:17.275] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:36:17.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:13:0) after 1m0s
[20:37:17.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:13:0)
[20:37:17.276] Timer tick, asking Buildbucket for the build status
[20:37:17.343] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:37:17.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:14:0) after 1m0s
[20:38:17.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:14:0)
[20:38:17.413] Timer tick, asking Buildbucket for the build status
[20:38:17.534] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:38:17.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:15:0) after 1m0s
[20:39:17.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:15:0)
[20:39:17.542] Timer tick, asking Buildbucket for the build status
[20:39:19.224] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:39:19.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:16:0) after 1m0s
[20:40:19.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:16:0)
[20:40:19.250] Timer tick, asking Buildbucket for the build status
[20:40:19.486] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:40:19.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:17:0) after 1m0s
[20:41:19.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:17:0)
[20:41:19.537] Timer tick, asking Buildbucket for the build status
[20:41:19.708] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:41:19.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:18:0) after 1m0s
[20:42:19.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:18:0)
[20:42:19.729] Timer tick, asking Buildbucket for the build status
[20:42:19.921] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:42:19.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:19:0) after 1m0s
[20:43:19.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:19:0)
[20:43:19.930] Timer tick, asking Buildbucket for the build status
[20:43:20.253] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:43:20.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:20:0) after 1m0s
[20:44:20.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:20:0)
[20:44:20.276] Timer tick, asking Buildbucket for the build status
[20:44:20.492] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:20.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:21:0) after 1m0s
[20:45:20.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:21:0)
[20:45:20.537] Timer tick, asking Buildbucket for the build status
[20:45:21.002] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:21.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:22:0) after 1m0s
[20:46:21.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:22:0)
[20:46:21.015] Timer tick, asking Buildbucket for the build status
[20:46:21.186] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:21.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:23:0) after 1m0s
[20:47:21.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:23:0)
[20:47:21.209] Timer tick, asking Buildbucket for the build status
[20:47:21.526] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:47:21.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:24:0) after 1m0s
[20:48:21.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:24:0)
[20:48:21.553] Timer tick, asking Buildbucket for the build status
[20:48:21.920] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:21.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:25:0) after 1m0s
[20:49:21.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:25:0)
[20:49:21.957] Timer tick, asking Buildbucket for the build status
[20:49:22.260] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:22.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:26:0) after 1m0s
[20:50:22.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:26:0)
[20:50:22.311] Timer tick, asking Buildbucket for the build status
[20:50:22.461] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:22.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:27:0) after 1m0s
[20:51:22.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:27:0)
[20:51:22.507] Timer tick, asking Buildbucket for the build status
[20:51:23.129] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:23.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:28:0) after 1m0s
[20:52:23.170] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:28:0)
[20:52:23.170] Timer tick, asking Buildbucket for the build status
[20:52:23.367] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:23.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:29:0) after 1m0s
[20:53:23.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:29:0)
[20:53:23.376] Timer tick, asking Buildbucket for the build status
[20:53:23.595] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:23.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:30:0) after 1m0s
[20:54:23.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:30:0)
[20:54:23.597] Timer tick, asking Buildbucket for the build status
[20:54:23.792] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:23.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:31:0) after 1m0s
[20:55:23.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:31:0)
[20:55:23.885] Timer tick, asking Buildbucket for the build status
[20:55:24.044] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:24.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:32:0) after 1m0s
[20:56:24.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:32:0)
[20:56:24.117] Timer tick, asking Buildbucket for the build status
[20:56:24.231] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:56:24.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:33:0) after 1m0s
[20:57:24.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:33:0)
[20:57:24.321] Timer tick, asking Buildbucket for the build status
[20:57:24.464] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:57:24.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:34:0) after 1m0s
[20:58:24.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:34:0)
[20:58:24.573] Timer tick, asking Buildbucket for the build status
[20:58:25.032] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:25.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:35:0) after 1m0s
[20:59:25.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:35:0)
[20:59:25.077] Timer tick, asking Buildbucket for the build status
[20:59:25.546] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:25.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:36:0) after 1m0s
[21:00:25.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:36:0)
[21:00:25.634] Timer tick, asking Buildbucket for the build status
[21:00:26.536] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:26.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:37:0) after 1m0s
[21:01:26.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:37:0)
[21:01:26.656] Timer tick, asking Buildbucket for the build status
[21:01:26.816] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:26.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:38:0) after 1m0s
[21:02:26.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:38:0)
[21:02:26.863] Timer tick, asking Buildbucket for the build status
[21:02:26.993] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:26.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:39:0) after 1m0s
[21:03:27.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:39:0)
[21:03:27.037] Timer tick, asking Buildbucket for the build status
[21:03:27.197] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:27.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:40:0) after 1m0s
[21:04:27.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:40:0)
[21:04:27.268] Timer tick, asking Buildbucket for the build status
[21:04:27.396] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:27.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:41:0) after 1m0s
[21:05:27.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:41:0)
[21:05:27.434] Timer tick, asking Buildbucket for the build status
[21:05:27.570] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:27.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:42:0) after 1m0s
[21:06:27.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:42:0)
[21:06:27.638] Timer tick, asking Buildbucket for the build status
[21:06:27.857] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:27.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:43:0) after 1m0s
[21:07:27.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:43:0)
[21:07:27.902] Timer tick, asking Buildbucket for the build status
[21:07:28.114] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:28.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:44:0) after 1m0s
[21:08:28.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:44:0)
[21:08:28.114] Timer tick, asking Buildbucket for the build status
[21:08:28.252] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:28.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:45:0) after 1m0s
[21:09:28.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:45:0)
[21:09:28.327] Timer tick, asking Buildbucket for the build status
[21:09:28.534] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:28.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:46:0) after 1m0s
[21:10:28.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:46:0)
[21:10:28.585] Timer tick, asking Buildbucket for the build status
[21:10:29.428] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:29.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:47:0) after 1m0s
[21:11:29.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:47:0)
[21:11:29.498] Timer tick, asking Buildbucket for the build status
[21:11:29.705] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:29.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:48:0) after 1m0s
[21:12:29.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:48:0)
[21:12:29.781] Timer tick, asking Buildbucket for the build status
[21:12:29.909] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:12:29.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:49:0) after 1m0s
[21:13:30.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:49:0)
[21:13:30.013] Timer tick, asking Buildbucket for the build status
[21:13:30.168] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:13:30.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:50:0) after 1m0s
[21:14:30.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:50:0)
[21:14:30.262] Timer tick, asking Buildbucket for the build status
[21:14:30.403] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:14:30.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:51:0) after 1m0s
[21:15:30.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:51:0)
[21:15:30.480] Timer tick, asking Buildbucket for the build status
[21:15:30.633] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:15:30.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:52:0) after 1m0s
[21:16:30.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:52:0)
[21:16:30.675] Timer tick, asking Buildbucket for the build status
[21:16:30.790] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:30.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:53:0) after 1m0s
[21:17:30.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:53:0)
[21:17:30.814] Timer tick, asking Buildbucket for the build status
[21:17:31.227] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:31.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:54:0) after 1m0s
[21:18:31.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:54:0)
[21:18:31.244] Timer tick, asking Buildbucket for the build status
[21:18:31.380] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:31.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:55:0) after 1m0s
[21:19:31.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:55:0)
[21:19:31.378] Timer tick, asking Buildbucket for the build status
[21:19:31.569] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:31.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:56:0) after 1m0s
[21:20:31.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:56:0)
[21:20:31.637] Timer tick, asking Buildbucket for the build status
[21:20:31.738] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:20:31.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:57:0) after 1m0s
[21:21:31.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:57:0)
[21:21:31.782] Timer tick, asking Buildbucket for the build status
[21:21:33.302] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:21:33.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:58:0) after 1m0s
[21:22:33.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:58:0)
[21:22:33.347] Timer tick, asking Buildbucket for the build status
[21:22:33.681] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:22:33.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:59:0) after 1m0s
[21:23:33.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:59:0)
[21:23:33.775] Timer tick, asking Buildbucket for the build status
[21:23:34.123] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:23:34.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:60:0) after 1m0s
[21:24:34.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:60:0)
[21:24:34.210] Timer tick, asking Buildbucket for the build status
[21:24:34.327] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:24:34.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:61:0) after 1m0s
[21:25:34.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:61:0)
[21:25:34.377] Timer tick, asking Buildbucket for the build status
[21:25:34.640] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:25:34.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:62:0) after 1m0s
[21:26:34.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:62:0)
[21:26:34.655] Timer tick, asking Buildbucket for the build status
[21:26:34.870] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:26:34.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:63:0) after 1m0s
[21:27:34.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:63:0)
[21:27:34.943] Timer tick, asking Buildbucket for the build status
[21:27:35.149] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:27:35.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:64:0) after 1m0s
[21:28:35.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:64:0)
[21:28:35.254] Timer tick, asking Buildbucket for the build status
[21:28:35.455] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:28:35.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:65:0) after 1m0s
[21:29:35.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:65:0)
[21:29:35.662] Timer tick, asking Buildbucket for the build status
[21:29:35.835] Build 8881653797406758480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:29:35.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:66:0) after 1m0s
[21:30:16.477] Received PubSub notification, asking Buildbucket for the build status
[21:30:16.684] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:36.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:66:0)
[21:30:36.586] Timer tick, asking Buildbucket for the build status
[21:30:38.024] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:38.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:68:0) after 1m0s
[21:31:38.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:68:0)
[21:31:38.547] Timer tick, asking Buildbucket for the build status
[21:31:38.688] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:38.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:69:0) after 1m0s
[21:32:38.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:69:0)
[21:32:38.729] Timer tick, asking Buildbucket for the build status
[21:32:38.850] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:38.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:70:0) after 1m0s
[21:33:39.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:70:0)
[21:33:39.004] Timer tick, asking Buildbucket for the build status
[21:33:39.235] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:39.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:71:0) after 1m0s
[21:34:39.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:71:0)
[21:34:39.375] Timer tick, asking Buildbucket for the build status
[21:34:39.575] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:39.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:72:0) after 1m0s
[21:35:39.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:72:0)
[21:35:39.651] Timer tick, asking Buildbucket for the build status
[21:35:40.188] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:40.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:73:0) after 1m0s
[21:36:40.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:73:0)
[21:36:40.239] Timer tick, asking Buildbucket for the build status
[21:36:40.408] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:40.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:74:0) after 1m0s
[21:37:40.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:74:0)
[21:37:40.449] Timer tick, asking Buildbucket for the build status
[21:37:40.637] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:40.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:75:0) after 1m0s
[21:38:40.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:75:0)
[21:38:40.700] Timer tick, asking Buildbucket for the build status
[21:38:47.751] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:47.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:76:0) after 1m0s
[21:39:47.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:76:0)
[21:39:47.942] Timer tick, asking Buildbucket for the build status
[21:39:48.018] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:48.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:77:0) after 1m0s
[21:40:48.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:77:0)
[21:40:48.212] Timer tick, asking Buildbucket for the build status
[21:40:48.989] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:48.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:78:0) after 1m0s
[21:41:49.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:78:0)
[21:41:49.085] Timer tick, asking Buildbucket for the build status
[21:41:49.278] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:49.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:79:0) after 1m0s
[21:42:49.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:79:0)
[21:42:49.299] Timer tick, asking Buildbucket for the build status
[21:42:49.537] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:49.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:80:0) after 1m0s
[21:43:49.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:80:0)
[21:43:49.568] Timer tick, asking Buildbucket for the build status
[21:43:49.684] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:49.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:81:0) after 1m0s
[21:44:49.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:81:0)
[21:44:49.709] Timer tick, asking Buildbucket for the build status
[21:44:49.986] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:49.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:82:0) after 1m0s
[21:45:50.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:82:0)
[21:45:50.053] Timer tick, asking Buildbucket for the build status
[21:45:51.003] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:51.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:83:0) after 1m0s
[21:46:51.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:83:0)
[21:46:51.043] Timer tick, asking Buildbucket for the build status
[21:46:51.322] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:51.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:84:0) after 1m0s
[21:47:51.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:84:0)
[21:47:51.349] Timer tick, asking Buildbucket for the build status
[21:47:51.431] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:51.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:85:0) after 1m0s
[21:48:51.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:85:0)
[21:48:51.454] Timer tick, asking Buildbucket for the build status
[21:48:52.144] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:52.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:86:0) after 1m0s
[21:49:52.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:86:0)
[21:49:52.247] Timer tick, asking Buildbucket for the build status
[21:49:52.399] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:52.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:87:0) after 1m0s
[21:50:52.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:87:0)
[21:50:52.497] Timer tick, asking Buildbucket for the build status
[21:50:52.968] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:52.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:88:0) after 1m0s
[21:51:53.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:88:0)
[21:51:53.061] Timer tick, asking Buildbucket for the build status
[21:51:53.179] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:53.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:89:0) after 1m0s
[21:52:53.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:89:0)
[21:52:53.283] Timer tick, asking Buildbucket for the build status
[21:52:53.483] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:53.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:90:0) after 1m0s
[21:53:53.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:90:0)
[21:53:53.562] Timer tick, asking Buildbucket for the build status
[21:53:53.790] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:53.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:91:0) after 1m0s
[21:54:53.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:91:0)
[21:54:53.903] Timer tick, asking Buildbucket for the build status
[21:54:54.002] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:54.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:92:0) after 1m0s
[21:55:54.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:92:0)
[21:55:54.036] Timer tick, asking Buildbucket for the build status
[21:55:55.591] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:55.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:93:0) after 1m0s
[21:56:55.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:93:0)
[21:56:55.775] Timer tick, asking Buildbucket for the build status
[21:56:55.885] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:55.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:94:0) after 1m0s
[21:57:55.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:94:0)
[21:57:55.982] Timer tick, asking Buildbucket for the build status
[21:57:56.195] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:56.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:95:0) after 1m0s
[21:58:56.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:95:0)
[21:58:56.241] Timer tick, asking Buildbucket for the build status
[21:58:56.349] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:56.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:96:0) after 1m0s
[21:59:56.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:96:0)
[21:59:56.526] Timer tick, asking Buildbucket for the build status
[21:59:56.634] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:56.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:97:0) after 1m0s
[22:00:56.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:97:0)
[22:00:56.674] Timer tick, asking Buildbucket for the build status
[22:00:56.824] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:56.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:98:0) after 1m0s
[22:01:56.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:98:0)
[22:01:56.901] Timer tick, asking Buildbucket for the build status
[22:01:57.076] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:57.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:99:0) after 1m0s
[22:02:57.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:99:0)
[22:02:57.064] Timer tick, asking Buildbucket for the build status
[22:02:57.316] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:57.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:100:0) after 1m0s
[22:03:57.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:100:0)
[22:03:57.383] Timer tick, asking Buildbucket for the build status
[22:03:57.525] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:57.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:101:0) after 1m0s
[22:04:57.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:101:0)
[22:04:57.597] Timer tick, asking Buildbucket for the build status
[22:04:57.773] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:57.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:102:0) after 1m0s
[22:05:57.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:102:0)
[22:05:57.780] Timer tick, asking Buildbucket for the build status
[22:05:57.990] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:57.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:103:0) after 1m0s
[22:06:58.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:103:0)
[22:06:58.026] Timer tick, asking Buildbucket for the build status
[22:06:58.231] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:58.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:104:0) after 1m0s
[22:07:58.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:104:0)
[22:07:58.292] Timer tick, asking Buildbucket for the build status
[22:07:58.472] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:58.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:105:0) after 1m0s
[22:08:58.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:105:0)
[22:08:58.696] Timer tick, asking Buildbucket for the build status
[22:08:58.783] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:58.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:106:0) after 1m0s
[22:09:58.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:106:0)
[22:09:58.810] Timer tick, asking Buildbucket for the build status
[22:09:59.294] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:59.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:107:0) after 1m0s
[22:10:59.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:107:0)
[22:10:59.304] Timer tick, asking Buildbucket for the build status
[22:10:59.612] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:59.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:108:0) after 1m0s
[22:11:59.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:108:0)
[22:11:59.729] Timer tick, asking Buildbucket for the build status
[22:12:00.251] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:00.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:109:0) after 1m0s
[22:13:00.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:109:0)
[22:13:00.312] Timer tick, asking Buildbucket for the build status
[22:13:00.456] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:00.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:110:0) after 1m0s
[22:14:00.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:110:0)
[22:14:00.761] Timer tick, asking Buildbucket for the build status
[22:14:01.054] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:01.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:111:0) after 1m0s
[22:15:01.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:111:0)
[22:15:01.556] Timer tick, asking Buildbucket for the build status
[22:15:01.938] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:01.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:112:0) after 1m0s
[22:16:01.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:112:0)
[22:16:01.987] Timer tick, asking Buildbucket for the build status
[22:16:02.223] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:02.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:113:0) after 1m0s
[22:17:02.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:113:0)
[22:17:02.258] Timer tick, asking Buildbucket for the build status
[22:17:02.796] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:02.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:114:0) after 1m0s
[22:18:02.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:114:0)
[22:18:02.834] Timer tick, asking Buildbucket for the build status
[22:18:03.044] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:03.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:115:0) after 1m0s
[22:19:03.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:115:0)
[22:19:03.165] Timer tick, asking Buildbucket for the build status
[22:19:03.278] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:03.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:116:0) after 1m0s
[22:20:03.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:116:0)
[22:20:03.337] Timer tick, asking Buildbucket for the build status
[22:20:03.675] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:03.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:117:0) after 1m0s
[22:21:03.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:117:0)
[22:21:03.700] Timer tick, asking Buildbucket for the build status
[22:21:04.028] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:04.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:118:0) after 1m0s
[22:22:04.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:118:0)
[22:22:04.057] Timer tick, asking Buildbucket for the build status
[22:22:04.226] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:04.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:119:0) after 1m0s
[22:23:04.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:119:0)
[22:23:04.471] Timer tick, asking Buildbucket for the build status
[22:23:04.905] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:04.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:120:0) after 1m0s
[22:24:05.080] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:120:0)
[22:24:05.080] Timer tick, asking Buildbucket for the build status
[22:24:06.441] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:06.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:121:0) after 1m0s
[22:25:06.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:121:0)
[22:25:06.591] Timer tick, asking Buildbucket for the build status
[22:25:07.162] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:07.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:122:0) after 1m0s
[22:26:07.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:122:0)
[22:26:07.338] Timer tick, asking Buildbucket for the build status
[22:26:07.469] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:07.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:123:0) after 1m0s
[22:27:07.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:123:0)
[22:27:07.531] Timer tick, asking Buildbucket for the build status
[22:27:07.946] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:07.946] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:124:0) after 1m0s
[22:28:08.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:124:0)
[22:28:08.108] Timer tick, asking Buildbucket for the build status
[22:28:08.519] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:08.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:125:0) after 1m0s
[22:29:08.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:125:0)
[22:29:08.577] Timer tick, asking Buildbucket for the build status
[22:29:08.711] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:08.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:126:0) after 1m0s
[22:30:08.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:126:0)
[22:30:08.740] Timer tick, asking Buildbucket for the build status
[22:30:10.254] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:10.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:127:0) after 1m0s
[22:31:10.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:127:0)
[22:31:10.288] Timer tick, asking Buildbucket for the build status
[22:31:10.460] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:10.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:128:0) after 1m0s
[22:32:10.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:128:0)
[22:32:10.522] Timer tick, asking Buildbucket for the build status
[22:32:11.665] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:11.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:129:0) after 1m0s
[22:33:11.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:129:0)
[22:33:11.751] Timer tick, asking Buildbucket for the build status
[22:33:11.931] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:11.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:130:0) after 1m0s
[22:34:12.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:130:0)
[22:34:12.070] Timer tick, asking Buildbucket for the build status
[22:34:12.202] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:12.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:131:0) after 1m0s
[22:35:12.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:131:0)
[22:35:12.211] Timer tick, asking Buildbucket for the build status
[22:35:17.262] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:17.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:132:0) after 1m0s
[22:36:17.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:132:0)
[22:36:17.292] Timer tick, asking Buildbucket for the build status
[22:36:17.824] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:17.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:133:0) after 1m0s
[22:37:17.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:133:0)
[22:37:17.894] Timer tick, asking Buildbucket for the build status
[22:37:18.118] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:18.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:134:0) after 1m0s
[22:38:18.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:134:0)
[22:38:18.168] Timer tick, asking Buildbucket for the build status
[22:38:18.360] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:18.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:135:0) after 1m0s
[22:39:18.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:135:0)
[22:39:18.384] Timer tick, asking Buildbucket for the build status
[22:39:18.494] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:18.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:136:0) after 1m0s
[22:40:18.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:136:0)
[22:40:18.517] Timer tick, asking Buildbucket for the build status
[22:40:18.700] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:18.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:137:0) after 1m0s
[22:41:18.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:137:0)
[22:41:18.731] Timer tick, asking Buildbucket for the build status
[22:41:19.226] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:19.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:138:0) after 1m0s
[22:42:19.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:138:0)
[22:42:19.325] Timer tick, asking Buildbucket for the build status
[22:42:19.648] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:19.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:139:0) after 1m0s
[22:43:19.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:139:0)
[22:43:19.723] Timer tick, asking Buildbucket for the build status
[22:43:19.889] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:19.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:140:0) after 1m0s
[22:44:19.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:140:0)
[22:44:19.923] Timer tick, asking Buildbucket for the build status
[22:44:20.103] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:20.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:141:0) after 1m0s
[22:45:20.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:141:0)
[22:45:20.174] Timer tick, asking Buildbucket for the build status
[22:45:20.512] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:20.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:142:0) after 1m0s
[22:46:20.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:142:0)
[22:46:20.550] Timer tick, asking Buildbucket for the build status
[22:46:20.745] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:20.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:143:0) after 1m0s
[22:47:20.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:143:0)
[22:47:20.801] Timer tick, asking Buildbucket for the build status
[22:47:20.961] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:20.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:144:0) after 1m0s
[22:48:21.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:144:0)
[22:48:21.002] Timer tick, asking Buildbucket for the build status
[22:48:21.103] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:21.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:145:0) after 1m0s
[22:49:21.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:145:0)
[22:49:21.159] Timer tick, asking Buildbucket for the build status
[22:49:21.298] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:21.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:146:0) after 1m0s
[22:50:21.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:146:0)
[22:50:21.446] Timer tick, asking Buildbucket for the build status
[22:50:21.620] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:21.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:147:0) after 1m0s
[22:51:21.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:147:0)
[22:51:21.798] Timer tick, asking Buildbucket for the build status
[22:51:21.948] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:21.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:148:0) after 1m0s
[22:52:22.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:148:0)
[22:52:22.092] Timer tick, asking Buildbucket for the build status
[22:52:22.288] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:22.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:149:0) after 1m0s
[22:53:22.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:149:0)
[22:53:22.418] Timer tick, asking Buildbucket for the build status
[22:53:22.482] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:22.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:150:0) after 1m0s
[22:54:22.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:150:0)
[22:54:22.526] Timer tick, asking Buildbucket for the build status
[22:54:22.689] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:22.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:151:0) after 1m0s
[22:55:22.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:151:0)
[22:55:22.862] Timer tick, asking Buildbucket for the build status
[22:55:23.034] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:23.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:152:0) after 1m0s
[22:56:23.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:152:0)
[22:56:23.040] Timer tick, asking Buildbucket for the build status
[22:56:23.252] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:23.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:153:0) after 1m0s
[22:57:23.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:153:0)
[22:57:23.306] Timer tick, asking Buildbucket for the build status
[22:57:23.494] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:23.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:154:0) after 1m0s
[22:58:23.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:154:0)
[22:58:23.538] Timer tick, asking Buildbucket for the build status
[22:58:23.688] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:23.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:155:0) after 1m0s
[22:59:23.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:155:0)
[22:59:23.818] Timer tick, asking Buildbucket for the build status
[22:59:24.162] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:24.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:156:0) after 1m0s
[23:00:24.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:156:0)
[23:00:24.266] Timer tick, asking Buildbucket for the build status
[23:00:24.466] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:24.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:157:0) after 1m0s
[23:01:24.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:157:0)
[23:01:24.526] Timer tick, asking Buildbucket for the build status
[23:01:25.013] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:25.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:158:0) after 1m0s
[23:02:25.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:158:0)
[23:02:25.056] Timer tick, asking Buildbucket for the build status
[23:02:25.210] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:25.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:159:0) after 1m0s
[23:03:25.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:159:0)
[23:03:25.271] Timer tick, asking Buildbucket for the build status
[23:03:25.386] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:25.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:160:0) after 1m0s
[23:04:25.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:160:0)
[23:04:25.474] Timer tick, asking Buildbucket for the build status
[23:04:25.734] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:25.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:161:0) after 1m0s
[23:05:25.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:161:0)
[23:05:25.880] Timer tick, asking Buildbucket for the build status
[23:05:29.388] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:29.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:162:0) after 1m0s
[23:06:29.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:162:0)
[23:06:29.478] Timer tick, asking Buildbucket for the build status
[23:06:29.602] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:29.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:163:0) after 1m0s
[23:07:29.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:163:0)
[23:07:29.690] Timer tick, asking Buildbucket for the build status
[23:07:29.895] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:29.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:164:0) after 1m0s
[23:08:29.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:164:0)
[23:08:29.923] Timer tick, asking Buildbucket for the build status
[23:08:30.003] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:30.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:165:0) after 1m0s
[23:09:30.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:165:0)
[23:09:30.039] Timer tick, asking Buildbucket for the build status
[23:09:30.168] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:30.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:166:0) after 1m0s
[23:10:30.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:166:0)
[23:10:30.218] Timer tick, asking Buildbucket for the build status
[23:10:35.778] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:35.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:167:0) after 1m0s
[23:11:35.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:167:0)
[23:11:35.813] Timer tick, asking Buildbucket for the build status
[23:11:36.379] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:36.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:168:0) after 1m0s
[23:12:36.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:168:0)
[23:12:36.478] Timer tick, asking Buildbucket for the build status
[23:12:37.065] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:37.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:169:0) after 1m0s
[23:13:37.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:169:0)
[23:13:37.168] Timer tick, asking Buildbucket for the build status
[23:13:37.330] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:37.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:170:0) after 1m0s
[23:14:37.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:170:0)
[23:14:37.377] Timer tick, asking Buildbucket for the build status
[23:14:37.446] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:37.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:171:0) after 1m0s
[23:15:37.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:171:0)
[23:15:37.510] Timer tick, asking Buildbucket for the build status
[23:15:38.552] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:38.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:172:0) after 1m0s
[23:16:38.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:172:0)
[23:16:38.658] Timer tick, asking Buildbucket for the build status
[23:16:38.872] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:38.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:173:0) after 1m0s
[23:17:39.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:173:0)
[23:17:39.037] Timer tick, asking Buildbucket for the build status
[23:17:39.183] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:39.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:174:0) after 1m0s
[23:18:39.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:174:0)
[23:18:39.329] Timer tick, asking Buildbucket for the build status
[23:18:39.638] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:39.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:175:0) after 1m0s
[23:19:39.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:175:0)
[23:19:39.742] Timer tick, asking Buildbucket for the build status
[23:19:39.971] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:39.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:176:0) after 1m0s
[23:20:40.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:176:0)
[23:20:40.044] Timer tick, asking Buildbucket for the build status
[23:20:41.160] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:41.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:177:0) after 1m0s
[23:21:41.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:177:0)
[23:21:41.232] Timer tick, asking Buildbucket for the build status
[23:21:41.335] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:41.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:178:0) after 1m0s
[23:22:41.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:178:0)
[23:22:41.361] Timer tick, asking Buildbucket for the build status
[23:22:41.522] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:41.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:179:0) after 1m0s
[23:23:41.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:179:0)
[23:23:41.560] Timer tick, asking Buildbucket for the build status
[23:23:41.717] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:41.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:180:0) after 1m0s
[23:24:41.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:180:0)
[23:24:41.758] Timer tick, asking Buildbucket for the build status
[23:24:42.044] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:42.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:181:0) after 1m0s
[23:25:42.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:181:0)
[23:25:42.081] Timer tick, asking Buildbucket for the build status
[23:25:42.938] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:42.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:182:0) after 1m0s
[23:26:42.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:182:0)
[23:26:42.981] Timer tick, asking Buildbucket for the build status
[23:26:43.142] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:43.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:183:0) after 1m0s
[23:27:43.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:183:0)
[23:27:43.208] Timer tick, asking Buildbucket for the build status
[23:27:43.637] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:43.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:184:0) after 1m0s
[23:28:43.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:184:0)
[23:28:43.666] Timer tick, asking Buildbucket for the build status
[23:28:43.865] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:43.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:185:0) after 1m0s
[23:29:43.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:185:0)
[23:29:43.900] Timer tick, asking Buildbucket for the build status
[23:29:44.114] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:44.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:186:0) after 1m0s
[23:30:44.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:186:0)
[23:30:44.167] Timer tick, asking Buildbucket for the build status
[23:30:49.005] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:49.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:187:0) after 1m0s
[23:31:49.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:187:0)
[23:31:49.011] Timer tick, asking Buildbucket for the build status
[23:31:49.334] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:49.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:188:0) after 1m0s
[23:32:49.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:188:0)
[23:32:49.409] Timer tick, asking Buildbucket for the build status
[23:32:49.587] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:49.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:189:0) after 1m0s
[23:33:49.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:189:0)
[23:33:49.666] Timer tick, asking Buildbucket for the build status
[23:33:49.816] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:49.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:190:0) after 1m0s
[23:34:49.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:190:0)
[23:34:49.816] Timer tick, asking Buildbucket for the build status
[23:34:49.948] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:49.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:191:0) after 1m0s
[23:35:50.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:191:0)
[23:35:50.110] Timer tick, asking Buildbucket for the build status
[23:35:50.653] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:50.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:192:0) after 1m0s
[23:36:50.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:192:0)
[23:36:50.779] Timer tick, asking Buildbucket for the build status
[23:36:51.173] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:51.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:193:0) after 1m0s
[23:37:51.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:193:0)
[23:37:51.299] Timer tick, asking Buildbucket for the build status
[23:37:51.413] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:51.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:194:0) after 1m0s
[23:38:52.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:194:0)
[23:38:52.292] Timer tick, asking Buildbucket for the build status
[23:38:52.422] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:52.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:195:0) after 1m0s
[23:39:52.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:195:0)
[23:39:52.458] Timer tick, asking Buildbucket for the build status
[23:39:52.982] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:52.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:196:0) after 1m0s
[23:40:53.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:196:0)
[23:40:53.054] Timer tick, asking Buildbucket for the build status
[23:40:53.524] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:53.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:197:0) after 1m0s
[23:41:53.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:197:0)
[23:41:53.606] Timer tick, asking Buildbucket for the build status
[23:41:53.823] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:53.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:198:0) after 1m0s
[23:42:53.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:198:0)
[23:42:53.898] Timer tick, asking Buildbucket for the build status
[23:42:54.046] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:54.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:199:0) after 1m0s
[23:43:54.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:199:0)
[23:43:54.118] Timer tick, asking Buildbucket for the build status
[23:43:54.557] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:54.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:200:0) after 1m0s
[23:44:54.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:200:0)
[23:44:54.678] Timer tick, asking Buildbucket for the build status
[23:44:54.975] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:54.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:201:0) after 1m0s
[23:45:55.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:201:0)
[23:45:55.029] Timer tick, asking Buildbucket for the build status
[23:45:55.554] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:55.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:202:0) after 1m0s
[23:46:55.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:202:0)
[23:46:55.596] Timer tick, asking Buildbucket for the build status
[23:46:55.759] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:55.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:203:0) after 1m0s
[23:47:55.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:203:0)
[23:47:55.796] Timer tick, asking Buildbucket for the build status
[23:47:55.960] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:55.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:204:0) after 1m0s
[23:48:56.050] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:204:0)
[23:48:56.050] Timer tick, asking Buildbucket for the build status
[23:48:56.552] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:56.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:205:0) after 1m0s
[23:49:56.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:205:0)
[23:49:56.551] Timer tick, asking Buildbucket for the build status
[23:49:56.746] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:56.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:206:0) after 1m0s
[23:50:57.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:206:0)
[23:50:57.003] Timer tick, asking Buildbucket for the build status
[23:50:59.050] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:59.050] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:207:0) after 1m0s
[23:51:59.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:207:0)
[23:51:59.412] Timer tick, asking Buildbucket for the build status
[23:51:59.621] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:59.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:208:0) after 1m0s
[23:52:59.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:208:0)
[23:52:59.773] Timer tick, asking Buildbucket for the build status
[23:52:59.981] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:59.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:209:0) after 1m0s
[23:54:00.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:209:0)
[23:54:00.217] Timer tick, asking Buildbucket for the build status
[23:54:00.397] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:00.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:210:0) after 1m0s
[23:55:00.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:210:0)
[23:55:00.567] Timer tick, asking Buildbucket for the build status
[23:55:01.175] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:01.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:211:0) after 1m0s
[23:56:01.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:211:0)
[23:56:01.264] Timer tick, asking Buildbucket for the build status
[23:56:01.391] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:01.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:212:0) after 1m0s
[23:57:01.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:212:0)
[23:57:01.490] Timer tick, asking Buildbucket for the build status
[23:57:01.678] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:01.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:213:0) after 1m0s
[23:58:01.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:213:0)
[23:58:01.740] Timer tick, asking Buildbucket for the build status
[23:58:01.863] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:01.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:214:0) after 1m0s
[23:59:07.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:214:0)
[23:59:07.197] Timer tick, asking Buildbucket for the build status
[23:59:07.377] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:07.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:215:0) after 1m0s
[00:00:07.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:215:0)
[00:00:07.443] Timer tick, asking Buildbucket for the build status
[00:00:07.638] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:07.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:216:0) after 1m0s
[00:01:07.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:216:0)
[00:01:07.698] Timer tick, asking Buildbucket for the build status
[00:01:07.838] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:07.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:217:0) after 1m0s
[00:02:07.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:217:0)
[00:02:07.985] Timer tick, asking Buildbucket for the build status
[00:02:09.123] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:09.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:218:0) after 1m0s
[00:03:09.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:218:0)
[00:03:09.163] Timer tick, asking Buildbucket for the build status
[00:03:09.456] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:09.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:219:0) after 1m0s
[00:04:09.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:219:0)
[00:04:09.577] Timer tick, asking Buildbucket for the build status
[00:04:09.988] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:09.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:220:0) after 1m0s
[00:05:10.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:220:0)
[00:05:10.101] Timer tick, asking Buildbucket for the build status
[00:05:10.230] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:10.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:221:0) after 1m0s
[00:06:10.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:221:0)
[00:06:10.394] Timer tick, asking Buildbucket for the build status
[00:06:10.562] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:10.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:222:0) after 1m0s
[00:07:10.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:222:0)
[00:07:10.646] Timer tick, asking Buildbucket for the build status
[00:07:10.890] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:10.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:223:0) after 1m0s
[00:08:10.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:223:0)
[00:08:10.980] Timer tick, asking Buildbucket for the build status
[00:08:11.165] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:11.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:224:0) after 1m0s
[00:09:11.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:224:0)
[00:09:11.281] Timer tick, asking Buildbucket for the build status
[00:09:11.760] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:11.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:225:0) after 1m0s
[00:10:11.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:225:0)
[00:10:11.824] Timer tick, asking Buildbucket for the build status
[00:10:12.004] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:12.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:226:0) after 1m0s
[00:11:12.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:226:0)
[00:11:12.119] Timer tick, asking Buildbucket for the build status
[00:11:12.383] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:12.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:227:0) after 1m0s
[00:12:12.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:227:0)
[00:12:12.450] Timer tick, asking Buildbucket for the build status
[00:12:12.641] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:12.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:228:0) after 1m0s
[00:13:12.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:228:0)
[00:13:12.802] Timer tick, asking Buildbucket for the build status
[00:13:12.937] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:12.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:229:0) after 1m0s
[00:14:12.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:229:0)
[00:14:12.996] Timer tick, asking Buildbucket for the build status
[00:14:13.213] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:13.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:230:0) after 1m0s
[00:15:13.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:230:0)
[00:15:13.339] Timer tick, asking Buildbucket for the build status
[00:15:13.633] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:13.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:231:0) after 1m0s
[00:16:13.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:231:0)
[00:16:13.712] Timer tick, asking Buildbucket for the build status
[00:16:13.846] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:13.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:232:0) after 1m0s
[00:17:14.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:232:0)
[00:17:14.695] Timer tick, asking Buildbucket for the build status
[00:17:14.857] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:14.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:233:0) after 1m0s
[00:18:15.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:233:0)
[00:18:15.089] Timer tick, asking Buildbucket for the build status
[00:18:15.420] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:15.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:234:0) after 1m0s
[00:19:15.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:234:0)
[00:19:15.626] Timer tick, asking Buildbucket for the build status
[00:19:15.839] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:15.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:235:0) after 1m0s
[00:20:15.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:235:0)
[00:20:15.956] Timer tick, asking Buildbucket for the build status
[00:20:16.186] Build 8881653797406758480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:16.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9047083859463661936:236:0) after 1m0s
[00:20:22.491] Received PubSub notification, asking Buildbucket for the build status
[00:20:22.575] Build 8881653797406758480: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:20:22.575] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1588206021062389",
    "created_by": "project:infra",
    "created_ts": "1588191908409710",
    "id": "8881653797406758480",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4103.34\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3bc50b9a-4401-447a-a17f-86e35ab4d51d\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4103.34\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4103.34\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3bc50b9a-4401-447a-a17f-86e35ab4d51d\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-ugxf\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"83.0.4103.34\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-ugxf\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5033-bf2739b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1588195815153111",
    "status": "COMPLETED",
    "status_changed_ts": "1588206021854021",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9047083859463661936",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8881653797406758480/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:build_from_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_task_id:4be06f3266b89110",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1588206021966799",
    "url": "https://ci.chromium.org/b/8881653797406758480",
    "utcnow_ts": "1588206022562217"
  }
}
[00:20:22.575] Invocation finished in 3h55m15.512023503s with status SUCCEEDED