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

• parent_buildername:publish_tarball
• user_agent:recipe

[22:52:30.753] New invocation is queued and will start shortly
[22:52:30.753] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[22:52:31.820] Starting the invocation (attempt 1)
[22:52:31.863] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:52:31.863] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:52:31.863] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9045262646872993824",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4149.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"f5dbb108-4e3e-4011-848b-38bf983ffcc3\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4149.2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9045262646872993824",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[22:52:32.348] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1589928751941606",
    "id": "8879832584963228720",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4149.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f5dbb108-4e3e-4011-848b-38bf983ffcc3\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4149.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1589928752131711",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9045262646872993824",
      "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/8879832584963228720/+/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": "1589928752131871",
    "url": "https://ci.chromium.org/b/8879832584963228720",
    "utcnow_ts": "1589928752336738"
  }
}
[22:52:32.348] Task URL: https://ci.chromium.org/b/8879832584963228720
[22:52:32.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:2:0) after 1m0s
[22:53:29.129] Received PubSub notification, asking Buildbucket for the build status
[22:53:29.240] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:32.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:2:0)
[22:53:32.365] Timer tick, asking Buildbucket for the build status
[22:53:32.741] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:32.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:4:0) after 1m0s
[22:54:32.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:4:0)
[22:54:32.712] Timer tick, asking Buildbucket for the build status
[22:54:32.878] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:32.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:5:0) after 1m0s
[22:55:32.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:5:0)
[22:55:32.899] Timer tick, asking Buildbucket for the build status
[22:55:33.188] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:33.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:6:0) after 1m0s
[22:56:33.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:6:0)
[22:56:33.188] Timer tick, asking Buildbucket for the build status
[22:56:33.334] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:33.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:7:0) after 1m0s
[22:57:33.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:7:0)
[22:57:33.354] Timer tick, asking Buildbucket for the build status
[22:57:33.505] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:33.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:8:0) after 1m0s
[22:58:33.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:8:0)
[22:58:33.522] Timer tick, asking Buildbucket for the build status
[22:58:33.673] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:33.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:9:0) after 1m0s
[22:59:33.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:9:0)
[22:59:33.721] Timer tick, asking Buildbucket for the build status
[22:59:34.338] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:34.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:10:0) after 1m0s
[23:00:34.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:10:0)
[23:00:34.780] Timer tick, asking Buildbucket for the build status
[23:00:35.001] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:35.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:11:0) after 1m0s
[23:01:35.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:11:0)
[23:01:35.138] Timer tick, asking Buildbucket for the build status
[23:01:35.322] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:35.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:12:0) after 1m0s
[23:02:35.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:12:0)
[23:02:35.581] Timer tick, asking Buildbucket for the build status
[23:02:35.906] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:35.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:13:0) after 1m0s
[23:03:36.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:13:0)
[23:03:36.065] Timer tick, asking Buildbucket for the build status
[23:03:36.392] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:36.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:14:0) after 1m0s
[23:04:36.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:14:0)
[23:04:36.431] Timer tick, asking Buildbucket for the build status
[23:04:36.616] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:36.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:15:0) after 1m0s
[23:05:36.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:15:0)
[23:05:36.728] Timer tick, asking Buildbucket for the build status
[23:05:37.255] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:37.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:16:0) after 1m0s
[23:06:37.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:16:0)
[23:06:37.376] Timer tick, asking Buildbucket for the build status
[23:06:37.549] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:37.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:17:0) after 1m0s
[23:07:37.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:17:0)
[23:07:37.623] Timer tick, asking Buildbucket for the build status
[23:07:38.328] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:38.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:18:0) after 1m0s
[23:08:38.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:18:0)
[23:08:38.450] Timer tick, asking Buildbucket for the build status
[23:08:38.658] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:38.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:19:0) after 1m0s
[23:09:38.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:19:0)
[23:09:38.718] Timer tick, asking Buildbucket for the build status
[23:09:39.249] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:39.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:20:0) after 1m0s
[23:10:39.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:20:0)
[23:10:39.293] Timer tick, asking Buildbucket for the build status
[23:10:39.492] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:39.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:21:0) after 1m0s
[23:11:39.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:21:0)
[23:11:39.478] Timer tick, asking Buildbucket for the build status
[23:11:39.687] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:39.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:22:0) after 1m0s
[23:12:39.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:22:0)
[23:12:39.699] Timer tick, asking Buildbucket for the build status
[23:12:39.901] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:39.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:23:0) after 1m0s
[23:13:39.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:23:0)
[23:13:39.972] Timer tick, asking Buildbucket for the build status
[23:13:40.145] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:40.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:24:0) after 1m0s
[23:14:40.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:24:0)
[23:14:40.162] Timer tick, asking Buildbucket for the build status
[23:14:40.317] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:40.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:25:0) after 1m0s
[23:15:40.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:25:0)
[23:15:40.350] Timer tick, asking Buildbucket for the build status
[23:15:40.501] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:40.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:26:0) after 1m0s
[23:16:40.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:26:0)
[23:16:40.483] Timer tick, asking Buildbucket for the build status
[23:16:40.669] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:40.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:27:0) after 1m0s
[23:17:40.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:27:0)
[23:17:40.701] Timer tick, asking Buildbucket for the build status
[23:17:40.973] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:40.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:28:0) after 1m0s
[23:18:41.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:28:0)
[23:18:41.009] Timer tick, asking Buildbucket for the build status
[23:18:41.186] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:41.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:29:0) after 1m0s
[23:19:41.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:29:0)
[23:19:41.209] Timer tick, asking Buildbucket for the build status
[23:19:42.042] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:42.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:30:0) after 1m0s
[23:20:42.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:30:0)
[23:20:42.052] Timer tick, asking Buildbucket for the build status
[23:20:47.204] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:47.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:31:0) after 1m0s
[23:21:47.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:31:0)
[23:21:47.224] Timer tick, asking Buildbucket for the build status
[23:21:48.287] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:48.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:32:0) after 1m0s
[23:22:48.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:32:0)
[23:22:48.349] Timer tick, asking Buildbucket for the build status
[23:22:48.518] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:48.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:33:0) after 1m0s
[23:23:48.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:33:0)
[23:23:48.764] Timer tick, asking Buildbucket for the build status
[23:23:49.173] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:49.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:34:0) after 1m0s
[23:24:49.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:34:0)
[23:24:49.266] Timer tick, asking Buildbucket for the build status
[23:24:50.659] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:50.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:35:0) after 1m0s
[23:25:50.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:35:0)
[23:25:50.890] Timer tick, asking Buildbucket for the build status
[23:25:51.078] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:51.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:36:0) after 1m0s
[23:26:51.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:36:0)
[23:26:51.282] Timer tick, asking Buildbucket for the build status
[23:26:51.427] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:51.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:37:0) after 1m0s
[23:27:51.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:37:0)
[23:27:51.608] Timer tick, asking Buildbucket for the build status
[23:27:51.754] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:51.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:38:0) after 1m0s
[23:28:51.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:38:0)
[23:28:51.843] Timer tick, asking Buildbucket for the build status
[23:28:51.971] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:51.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:39:0) after 1m0s
[23:29:52.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:39:0)
[23:29:52.192] Timer tick, asking Buildbucket for the build status
[23:29:52.302] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:52.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:40:0) after 1m0s
[23:30:52.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:40:0)
[23:30:52.539] Timer tick, asking Buildbucket for the build status
[23:30:52.678] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:52.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:41:0) after 1m0s
[23:31:52.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:41:0)
[23:31:52.734] Timer tick, asking Buildbucket for the build status
[23:31:53.110] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:53.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:42:0) after 1m0s
[23:32:53.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:42:0)
[23:32:53.430] Timer tick, asking Buildbucket for the build status
[23:32:53.636] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:53.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:43:0) after 1m0s
[23:33:53.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:43:0)
[23:33:53.717] Timer tick, asking Buildbucket for the build status
[23:33:53.914] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:53.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:44:0) after 1m0s
[23:34:53.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:44:0)
[23:34:53.973] Timer tick, asking Buildbucket for the build status
[23:34:54.491] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:54.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:45:0) after 1m0s
[23:35:54.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:45:0)
[23:35:54.605] Timer tick, asking Buildbucket for the build status
[23:35:54.986] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:54.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:46:0) after 1m0s
[23:36:55.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:46:0)
[23:36:55.027] Timer tick, asking Buildbucket for the build status
[23:36:55.444] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:55.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:47:0) after 1m0s
[23:37:55.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:47:0)
[23:37:55.469] Timer tick, asking Buildbucket for the build status
[23:37:56.082] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:56.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:48:0) after 1m0s
[23:38:56.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:48:0)
[23:38:56.105] Timer tick, asking Buildbucket for the build status
[23:38:56.573] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:56.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:49:0) after 1m0s
[23:39:56.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:49:0)
[23:39:56.651] Timer tick, asking Buildbucket for the build status
[23:39:56.833] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:56.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:50:0) after 1m0s
[23:40:56.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:50:0)
[23:40:56.942] Timer tick, asking Buildbucket for the build status
[23:40:57.456] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:57.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:51:0) after 1m0s
[23:41:57.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:51:0)
[23:41:57.605] Timer tick, asking Buildbucket for the build status
[23:41:57.748] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:57.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:52:0) after 1m0s
[23:42:57.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:52:0)
[23:42:57.795] Timer tick, asking Buildbucket for the build status
[23:42:57.983] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:57.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:53:0) after 1m0s
[23:43:58.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:53:0)
[23:43:58.051] Timer tick, asking Buildbucket for the build status
[23:43:58.321] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:58.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:54:0) after 1m0s
[23:44:58.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:54:0)
[23:44:58.345] Timer tick, asking Buildbucket for the build status
[23:44:58.756] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:58.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:55:0) after 1m0s
[23:45:58.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:55:0)
[23:45:58.847] Timer tick, asking Buildbucket for the build status
[23:45:59.023] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:59.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:56:0) after 1m0s
[23:46:59.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:56:0)
[23:46:59.046] Timer tick, asking Buildbucket for the build status
[23:46:59.151] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:59.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:57:0) after 1m0s
[23:47:59.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:57:0)
[23:47:59.220] Timer tick, asking Buildbucket for the build status
[23:47:59.779] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:59.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:58:0) after 1m0s
[23:49:00.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:58:0)
[23:49:00.279] Timer tick, asking Buildbucket for the build status
[23:49:00.825] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:00.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:59:0) after 1m0s
[23:50:01.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:59:0)
[23:50:01.779] Timer tick, asking Buildbucket for the build status
[23:50:01.923] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:01.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:60:0) after 1m0s
[23:51:01.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:60:0)
[23:51:01.939] Timer tick, asking Buildbucket for the build status
[23:51:02.071] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:02.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:61:0) after 1m0s
[23:52:02.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:61:0)
[23:52:02.111] Timer tick, asking Buildbucket for the build status
[23:52:02.277] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:02.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:62:0) after 1m0s
[23:53:02.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:62:0)
[23:53:02.380] Timer tick, asking Buildbucket for the build status
[23:53:02.529] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:02.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:63:0) after 1m0s
[23:54:02.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:63:0)
[23:54:02.795] Timer tick, asking Buildbucket for the build status
[23:54:02.951] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:02.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:64:0) after 1m0s
[23:55:03.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:64:0)
[23:55:03.218] Timer tick, asking Buildbucket for the build status
[23:55:03.482] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:03.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:65:0) after 1m0s
[23:56:03.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:65:0)
[23:56:03.538] Timer tick, asking Buildbucket for the build status
[23:56:03.713] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:03.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:66:0) after 1m0s
[23:57:03.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:66:0)
[23:57:03.771] Timer tick, asking Buildbucket for the build status
[23:57:04.599] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:04.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:67:0) after 1m0s
[23:58:04.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:67:0)
[23:58:04.667] Timer tick, asking Buildbucket for the build status
[23:58:05.043] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:05.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:68:0) after 1m0s
[23:59:05.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:68:0)
[23:59:05.249] Timer tick, asking Buildbucket for the build status
[23:59:05.515] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:05.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:69:0) after 1m0s
[00:00:05.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:69:0)
[00:00:05.522] Timer tick, asking Buildbucket for the build status
[00:00:05.658] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:05.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:70:0) after 1m0s
[00:01:05.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:70:0)
[00:01:05.713] Timer tick, asking Buildbucket for the build status
[00:01:06.124] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:06.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:71:0) after 1m0s
[00:02:06.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:71:0)
[00:02:06.160] Timer tick, asking Buildbucket for the build status
[00:02:06.654] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:06.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:72:0) after 1m0s
[00:03:06.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:72:0)
[00:03:06.685] Timer tick, asking Buildbucket for the build status
[00:03:07.283] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:07.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:73:0) after 1m0s
[00:04:07.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:73:0)
[00:04:07.416] Timer tick, asking Buildbucket for the build status
[00:04:07.591] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:07.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:74:0) after 1m0s
[00:05:07.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:74:0)
[00:05:07.705] Timer tick, asking Buildbucket for the build status
[00:05:07.863] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:07.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:75:0) after 1m0s
[00:06:07.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:75:0)
[00:06:07.909] Timer tick, asking Buildbucket for the build status
[00:06:08.047] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:08.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:76:0) after 1m0s
[00:07:08.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:76:0)
[00:07:08.085] Timer tick, asking Buildbucket for the build status
[00:07:08.301] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:08.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:77:0) after 1m0s
[00:08:08.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:77:0)
[00:08:08.392] Timer tick, asking Buildbucket for the build status
[00:08:11.488] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:11.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:78:0) after 1m0s
[00:09:11.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:78:0)
[00:09:11.766] Timer tick, asking Buildbucket for the build status
[00:09:12.227] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:12.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:79:0) after 1m0s
[00:10:12.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:79:0)
[00:10:12.241] Timer tick, asking Buildbucket for the build status
[00:10:12.565] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:12.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:80:0) after 1m0s
[00:11:12.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:80:0)
[00:11:12.582] Timer tick, asking Buildbucket for the build status
[00:11:12.748] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:12.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:81:0) after 1m0s
[00:12:12.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:81:0)
[00:12:12.798] Timer tick, asking Buildbucket for the build status
[00:12:12.973] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:12.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:82:0) after 1m0s
[00:13:13.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:82:0)
[00:13:13.137] Timer tick, asking Buildbucket for the build status
[00:13:13.318] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:13.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:83:0) after 1m0s
[00:14:13.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:83:0)
[00:14:13.660] Timer tick, asking Buildbucket for the build status
[00:14:13.859] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:13.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:84:0) after 1m0s
[00:15:13.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:84:0)
[00:15:13.880] Timer tick, asking Buildbucket for the build status
[00:15:14.440] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:14.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:85:0) after 1m0s
[00:16:14.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:85:0)
[00:16:14.477] Timer tick, asking Buildbucket for the build status
[00:16:14.693] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:14.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:86:0) after 1m0s
[00:17:14.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:86:0)
[00:17:14.759] Timer tick, asking Buildbucket for the build status
[00:17:15.114] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:15.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:87:0) after 1m0s
[00:18:15.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:87:0)
[00:18:15.136] Timer tick, asking Buildbucket for the build status
[00:18:15.334] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:15.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:88:0) after 1m0s
[00:19:15.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:88:0)
[00:19:15.390] Timer tick, asking Buildbucket for the build status
[00:19:15.583] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:15.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:89:0) after 1m0s
[00:20:15.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:89:0)
[00:20:15.733] Timer tick, asking Buildbucket for the build status
[00:20:16.172] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:16.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:90:0) after 1m0s
[00:21:16.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:90:0)
[00:21:16.450] Timer tick, asking Buildbucket for the build status
[00:21:16.782] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:16.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:91:0) after 1m0s
[00:22:16.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:91:0)
[00:22:16.885] Timer tick, asking Buildbucket for the build status
[00:22:17.358] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:17.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:92:0) after 1m0s
[00:23:17.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:92:0)
[00:23:17.904] Timer tick, asking Buildbucket for the build status
[00:23:18.264] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:18.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:93:0) after 1m0s
[00:24:18.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:93:0)
[00:24:18.612] Timer tick, asking Buildbucket for the build status
[00:24:19.203] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:19.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:94:0) after 1m0s
[00:25:19.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:94:0)
[00:25:19.427] Timer tick, asking Buildbucket for the build status
[00:25:19.784] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:19.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:95:0) after 1m0s
[00:26:19.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:95:0)
[00:26:19.847] Timer tick, asking Buildbucket for the build status
[00:26:21.510] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:21.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:96:0) after 1m0s
[00:27:21.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:96:0)
[00:27:21.770] Timer tick, asking Buildbucket for the build status
[00:27:21.938] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:21.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:97:0) after 1m0s
[00:28:22.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:97:0)
[00:28:22.047] Timer tick, asking Buildbucket for the build status
[00:28:22.552] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:22.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:98:0) after 1m0s
[00:29:22.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:98:0)
[00:29:22.689] Timer tick, asking Buildbucket for the build status
[00:29:22.844] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:22.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:99:0) after 1m0s
[00:30:22.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:99:0)
[00:30:22.864] Timer tick, asking Buildbucket for the build status
[00:30:23.302] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:23.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:100:0) after 1m0s
[00:31:23.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:100:0)
[00:31:23.397] Timer tick, asking Buildbucket for the build status
[00:31:23.969] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:23.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:101:0) after 1m0s
[00:32:24.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:101:0)
[00:32:24.115] Timer tick, asking Buildbucket for the build status
[00:32:25.790] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:25.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:102:0) after 1m0s
[00:33:25.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:102:0)
[00:33:25.865] Timer tick, asking Buildbucket for the build status
[00:33:26.246] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:26.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:103:0) after 1m0s
[00:34:26.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:103:0)
[00:34:26.350] Timer tick, asking Buildbucket for the build status
[00:34:27.780] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:27.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:104:0) after 1m0s
[00:35:27.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:104:0)
[00:35:27.779] Timer tick, asking Buildbucket for the build status
[00:35:30.979] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:30.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:105:0) after 1m0s
[00:36:31.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:105:0)
[00:36:31.033] Timer tick, asking Buildbucket for the build status
[00:36:36.824] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:36.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:106:0) after 1m0s
[00:37:37.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:106:0)
[00:37:37.244] Timer tick, asking Buildbucket for the build status
[00:37:37.755] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:37.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:107:0) after 1m0s
[00:38:38.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:107:0)
[00:38:38.393] Timer tick, asking Buildbucket for the build status
[00:38:39.087] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:39.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:108:0) after 1m0s
[00:39:39.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:108:0)
[00:39:39.364] Timer tick, asking Buildbucket for the build status
[00:39:39.542] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:39.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:109:0) after 1m0s
[00:40:39.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:109:0)
[00:40:39.776] Timer tick, asking Buildbucket for the build status
[00:40:40.450] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:40.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:110:0) after 1m0s
[00:41:40.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:110:0)
[00:41:40.652] Timer tick, asking Buildbucket for the build status
[00:41:40.823] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:40.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:111:0) after 1m0s
[00:42:40.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:111:0)
[00:42:40.929] Timer tick, asking Buildbucket for the build status
[00:42:41.575] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:41.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:112:0) after 1m0s
[00:43:41.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:112:0)
[00:43:41.651] Timer tick, asking Buildbucket for the build status
[00:43:41.852] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:41.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:113:0) after 1m0s
[00:44:41.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:113:0)
[00:44:41.886] Timer tick, asking Buildbucket for the build status
[00:44:42.067] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:42.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:114:0) after 1m0s
[00:45:42.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:114:0)
[00:45:42.154] Timer tick, asking Buildbucket for the build status
[00:45:42.356] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:42.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:115:0) after 1m0s
[00:46:42.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:115:0)
[00:46:42.407] Timer tick, asking Buildbucket for the build status
[00:46:42.537] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:42.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:116:0) after 1m0s
[00:47:42.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:116:0)
[00:47:42.586] Timer tick, asking Buildbucket for the build status
[00:47:42.722] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:42.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:117:0) after 1m0s
[00:48:42.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:117:0)
[00:48:42.758] Timer tick, asking Buildbucket for the build status
[00:48:43.289] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:43.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:118:0) after 1m0s
[00:49:43.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:118:0)
[00:49:43.315] Timer tick, asking Buildbucket for the build status
[00:49:43.506] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:43.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:119:0) after 1m0s
[00:50:43.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:119:0)
[00:50:43.548] Timer tick, asking Buildbucket for the build status
[00:50:43.746] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:43.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:120:0) after 1m0s
[00:51:43.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:120:0)
[00:51:43.784] Timer tick, asking Buildbucket for the build status
[00:51:43.961] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:43.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:121:0) after 1m0s
[00:52:43.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:121:0)
[00:52:43.983] Timer tick, asking Buildbucket for the build status
[00:52:44.202] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:44.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:122:0) after 1m0s
[00:53:44.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:122:0)
[00:53:44.240] Timer tick, asking Buildbucket for the build status
[00:53:44.586] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:44.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:123:0) after 1m0s
[00:54:44.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:123:0)
[00:54:44.608] Timer tick, asking Buildbucket for the build status
[00:54:45.099] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:45.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:124:0) after 1m0s
[00:55:45.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:124:0)
[00:55:45.132] Timer tick, asking Buildbucket for the build status
[00:55:45.999] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:45.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:125:0) after 1m0s
[00:56:46.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:125:0)
[00:56:46.104] Timer tick, asking Buildbucket for the build status
[00:56:46.983] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:46.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:126:0) after 1m0s
[00:57:47.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:126:0)
[00:57:47.040] Timer tick, asking Buildbucket for the build status
[00:57:47.229] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:47.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:127:0) after 1m0s
[00:58:47.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:127:0)
[00:58:47.263] Timer tick, asking Buildbucket for the build status
[00:58:47.514] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:47.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:128:0) after 1m0s
[00:59:47.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:128:0)
[00:59:47.555] Timer tick, asking Buildbucket for the build status
[00:59:47.694] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:47.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:129:0) after 1m0s
[01:00:47.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:129:0)
[01:00:47.709] Timer tick, asking Buildbucket for the build status
[01:00:48.782] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:48.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:130:0) after 1m0s
[01:01:48.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:130:0)
[01:01:48.818] Timer tick, asking Buildbucket for the build status
[01:01:48.948] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:48.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:131:0) after 1m0s
[01:02:49.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:131:0)
[01:02:49.049] Timer tick, asking Buildbucket for the build status
[01:02:49.373] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:49.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:132:0) after 1m0s
[01:03:49.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:132:0)
[01:03:49.451] Timer tick, asking Buildbucket for the build status
[01:03:49.632] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:49.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:133:0) after 1m0s
[01:04:49.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:133:0)
[01:04:49.707] Timer tick, asking Buildbucket for the build status
[01:04:49.867] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:49.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:134:0) after 1m0s
[01:05:49.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:134:0)
[01:05:49.945] Timer tick, asking Buildbucket for the build status
[01:05:52.357] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:52.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:135:0) after 1m0s
[01:06:52.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:135:0)
[01:06:52.455] Timer tick, asking Buildbucket for the build status
[01:06:52.635] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:52.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:136:0) after 1m0s
[01:07:52.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:136:0)
[01:07:52.690] Timer tick, asking Buildbucket for the build status
[01:07:53.014] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:53.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:137:0) after 1m0s
[01:08:53.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:137:0)
[01:08:53.041] Timer tick, asking Buildbucket for the build status
[01:08:53.289] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:53.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:138:0) after 1m0s
[01:09:53.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:138:0)
[01:09:53.416] Timer tick, asking Buildbucket for the build status
[01:09:55.451] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:55.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:139:0) after 1m0s
[01:10:55.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:139:0)
[01:10:55.533] Timer tick, asking Buildbucket for the build status
[01:10:56.852] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:56.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:140:0) after 1m0s
[01:11:56.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:140:0)
[01:11:56.976] Timer tick, asking Buildbucket for the build status
[01:11:57.451] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:57.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:141:0) after 1m0s
[01:12:59.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:141:0)
[01:12:59.138] Timer tick, asking Buildbucket for the build status
[01:12:59.402] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:59.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:142:0) after 1m0s
[01:13:59.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:142:0)
[01:13:59.752] Timer tick, asking Buildbucket for the build status
[01:14:00.207] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:00.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:143:0) after 1m0s
[01:15:00.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:143:0)
[01:15:00.851] Timer tick, asking Buildbucket for the build status
[01:15:01.111] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:01.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:144:0) after 1m0s
[01:16:01.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:144:0)
[01:16:01.592] Timer tick, asking Buildbucket for the build status
[01:16:02.011] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:02.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:145:0) after 1m0s
[01:17:02.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:145:0)
[01:17:02.085] Timer tick, asking Buildbucket for the build status
[01:17:02.641] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:02.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:146:0) after 1m0s
[01:18:02.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:146:0)
[01:18:02.798] Timer tick, asking Buildbucket for the build status
[01:18:03.288] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:03.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:147:0) after 1m0s
[01:19:03.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:147:0)
[01:19:03.319] Timer tick, asking Buildbucket for the build status
[01:19:03.619] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:03.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:148:0) after 1m0s
[01:20:03.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:148:0)
[01:20:03.690] Timer tick, asking Buildbucket for the build status
[01:20:04.071] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:04.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:149:0) after 1m0s
[01:21:04.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:149:0)
[01:21:04.177] Timer tick, asking Buildbucket for the build status
[01:21:06.102] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:06.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:150:0) after 1m0s
[01:22:06.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:150:0)
[01:22:06.100] Timer tick, asking Buildbucket for the build status
[01:22:06.374] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:06.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:151:0) after 1m0s
[01:23:06.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:151:0)
[01:23:06.456] Timer tick, asking Buildbucket for the build status
[01:23:06.611] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:06.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:152:0) after 1m0s
[01:24:06.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:152:0)
[01:24:06.904] Timer tick, asking Buildbucket for the build status
[01:24:07.088] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:07.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:153:0) after 1m0s
[01:25:07.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:153:0)
[01:25:07.217] Timer tick, asking Buildbucket for the build status
[01:25:07.357] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:07.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:154:0) after 1m0s
[01:26:07.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:154:0)
[01:26:07.478] Timer tick, asking Buildbucket for the build status
[01:26:07.620] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:07.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:155:0) after 1m0s
[01:27:07.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:155:0)
[01:27:07.672] Timer tick, asking Buildbucket for the build status
[01:27:07.970] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:07.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:156:0) after 1m0s
[01:28:08.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:156:0)
[01:28:08.103] Timer tick, asking Buildbucket for the build status
[01:28:08.280] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:08.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:157:0) after 1m0s
[01:29:08.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:157:0)
[01:29:08.377] Timer tick, asking Buildbucket for the build status
[01:29:08.726] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:08.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:158:0) after 1m0s
[01:30:08.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:158:0)
[01:30:08.795] Timer tick, asking Buildbucket for the build status
[01:30:09.133] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:09.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:159:0) after 1m0s
[01:31:09.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:159:0)
[01:31:09.169] Timer tick, asking Buildbucket for the build status
[01:31:09.336] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:09.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:160:0) after 1m0s
[01:32:09.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:160:0)
[01:32:09.500] Timer tick, asking Buildbucket for the build status
[01:32:09.675] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:09.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:161:0) after 1m0s
[01:33:09.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:161:0)
[01:33:09.817] Timer tick, asking Buildbucket for the build status
[01:33:11.505] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:11.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:162:0) after 1m0s
[01:34:11.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:162:0)
[01:34:11.821] Timer tick, asking Buildbucket for the build status
[01:34:12.654] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:12.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:163:0) after 1m0s
[01:35:12.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:163:0)
[01:35:12.901] Timer tick, asking Buildbucket for the build status
[01:35:13.098] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:13.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:164:0) after 1m0s
[01:36:13.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:164:0)
[01:36:13.330] Timer tick, asking Buildbucket for the build status
[01:36:13.482] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:13.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:165:0) after 1m0s
[01:37:13.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:165:0)
[01:37:13.645] Timer tick, asking Buildbucket for the build status
[01:37:15.131] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:15.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:166:0) after 1m0s
[01:38:15.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:166:0)
[01:38:15.239] Timer tick, asking Buildbucket for the build status
[01:38:15.400] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:15.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:167:0) after 1m0s
[01:39:15.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:167:0)
[01:39:15.675] Timer tick, asking Buildbucket for the build status
[01:39:15.821] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:15.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:168:0) after 1m0s
[01:40:15.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:168:0)
[01:40:15.807] Timer tick, asking Buildbucket for the build status
[01:40:15.957] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:15.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:169:0) after 1m0s
[01:41:16.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:169:0)
[01:41:16.192] Timer tick, asking Buildbucket for the build status
[01:41:16.382] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:16.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:170:0) after 1m0s
[01:42:16.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:170:0)
[01:42:16.717] Timer tick, asking Buildbucket for the build status
[01:42:16.952] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:16.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:171:0) after 1m0s
[01:43:17.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:171:0)
[01:43:17.254] Timer tick, asking Buildbucket for the build status
[01:43:17.442] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:17.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:172:0) after 1m0s
[01:44:17.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:172:0)
[01:44:17.695] Timer tick, asking Buildbucket for the build status
[01:44:18.094] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:18.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:173:0) after 1m0s
[01:45:18.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:173:0)
[01:45:18.338] Timer tick, asking Buildbucket for the build status
[01:45:19.148] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:19.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:174:0) after 1m0s
[01:46:19.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:174:0)
[01:46:19.628] Timer tick, asking Buildbucket for the build status
[01:46:19.809] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:19.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:175:0) after 1m0s
[01:47:20.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:175:0)
[01:47:20.179] Timer tick, asking Buildbucket for the build status
[01:47:20.355] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:20.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:176:0) after 1m0s
[01:48:20.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:176:0)
[01:48:20.481] Timer tick, asking Buildbucket for the build status
[01:48:20.906] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:20.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:177:0) after 1m0s
[01:49:20.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:177:0)
[01:49:20.968] Timer tick, asking Buildbucket for the build status
[01:49:21.122] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:21.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:178:0) after 1m0s
[01:50:21.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:178:0)
[01:50:21.243] Timer tick, asking Buildbucket for the build status
[01:50:21.404] Build 8879832584963228720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:21.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9045262646872993824:179:0) after 1m0s
[01:51:09.079] Received PubSub notification, asking Buildbucket for the build status
[01:51:09.167] Build 8879832584963228720: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:51:09.167] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1589939463189254",
    "created_by": "project:infra",
    "created_ts": "1589928751941606",
    "id": "8879832584963228720",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4149.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f5dbb108-4e3e-4011-848b-38bf983ffcc3\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4149.2\"}}",
    "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\": \"85.0.4149.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"f5dbb108-4e3e-4011-848b-38bf983ffcc3\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-r6hx\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"85.0.4149.2\"}, \"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-r6hx\"], \"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\": [\"5100-d2625c1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1589928808143435",
    "status": "COMPLETED",
    "status_changed_ts": "1589939464038936",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9045262646872993824",
      "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/8879832584963228720/+/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:4c47f512050c6e10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1589939464601607",
    "url": "https://ci.chromium.org/b/8879832584963228720",
    "utcnow_ts": "1589939469157139"
  }
}
[01:51:09.167] Invocation finished in 2h58m38.43117628s with status SUCCEEDED