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

• parent_buildername:publish_tarball
• user_agent:recipe

[15:31:30.246] New invocation is queued and will start shortly
[15:31:30.246] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[15:31:31.396] Starting the invocation (attempt 1)
[15:31:31.471] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:31:31.471] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:31:31.471] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9042119498900538272",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4180.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"e1f4757d-7452-4e7f-8601-c8418a36e0ff\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4180.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9042119498900538272",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[15:31:32.238] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1592926291601456",
    "id": "8876689436816201808",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4180.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e1f4757d-7452-4e7f-8601-c8418a36e0ff\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4180.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1592926291934730",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9042119498900538272",
      "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/8876689436816201808/+/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": "1592926291934954",
    "url": "https://ci.chromium.org/b/8876689436816201808",
    "utcnow_ts": "1592926292222234"
  }
}
[15:31:32.238] Task URL: https://ci.chromium.org/b/8876689436816201808
[15:31:32.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:2:0) after 1m0s
[15:32:32.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:2:0)
[15:32:32.241] Timer tick, asking Buildbucket for the build status
[15:32:32.381] Build 8876689436816201808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:32:32.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:3:0) after 1m0s
[15:33:32.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:3:0)
[15:33:32.460] Timer tick, asking Buildbucket for the build status
[15:33:32.935] Build 8876689436816201808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:33:32.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:4:0) after 1m0s
[15:34:33.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:4:0)
[15:34:33.024] Timer tick, asking Buildbucket for the build status
[15:34:33.150] Build 8876689436816201808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:34:33.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:5:0) after 1m0s
[15:34:36.323] Received PubSub notification, asking Buildbucket for the build status
[15:34:36.533] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:33.170] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:5:0)
[15:35:33.170] Timer tick, asking Buildbucket for the build status
[15:35:34.386] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:34.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:7:0) after 1m0s
[15:36:34.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:7:0)
[15:36:34.427] Timer tick, asking Buildbucket for the build status
[15:36:34.510] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:34.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:8:0) after 1m0s
[15:37:34.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:8:0)
[15:37:34.553] Timer tick, asking Buildbucket for the build status
[15:37:35.402] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:35.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:9:0) after 1m0s
[15:38:35.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:9:0)
[15:38:35.468] Timer tick, asking Buildbucket for the build status
[15:38:35.704] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:35.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:10:0) after 1m0s
[15:39:35.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:10:0)
[15:39:35.731] Timer tick, asking Buildbucket for the build status
[15:39:35.796] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:35.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:11:0) after 1m0s
[15:40:35.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:11:0)
[15:40:35.815] Timer tick, asking Buildbucket for the build status
[15:40:35.909] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:35.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:12:0) after 1m0s
[15:41:35.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:12:0)
[15:41:35.952] Timer tick, asking Buildbucket for the build status
[15:41:36.031] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:36.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:13:0) after 1m0s
[15:42:36.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:13:0)
[15:42:36.109] Timer tick, asking Buildbucket for the build status
[15:42:36.473] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:36.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:14:0) after 1m0s
[15:43:36.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:14:0)
[15:43:36.513] Timer tick, asking Buildbucket for the build status
[15:43:37.459] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:37.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:15:0) after 1m0s
[15:44:37.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:15:0)
[15:44:37.543] Timer tick, asking Buildbucket for the build status
[15:44:37.690] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:37.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:16:0) after 1m0s
[15:45:37.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:16:0)
[15:45:37.736] Timer tick, asking Buildbucket for the build status
[15:45:38.297] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:38.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:17:0) after 1m0s
[15:46:38.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:17:0)
[15:46:38.366] Timer tick, asking Buildbucket for the build status
[15:46:38.853] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:38.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:18:0) after 1m0s
[15:47:38.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:18:0)
[15:47:38.964] Timer tick, asking Buildbucket for the build status
[15:47:39.055] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:39.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:19:0) after 1m0s
[15:48:39.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:19:0)
[15:48:39.216] Timer tick, asking Buildbucket for the build status
[15:48:45.106] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:45.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:20:0) after 1m0s
[15:49:45.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:20:0)
[15:49:45.128] Timer tick, asking Buildbucket for the build status
[15:49:45.730] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:45.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:21:0) after 1m0s
[15:50:45.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:21:0)
[15:50:45.730] Timer tick, asking Buildbucket for the build status
[15:50:45.897] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:45.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:22:0) after 1m0s
[15:51:45.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:22:0)
[15:51:45.933] Timer tick, asking Buildbucket for the build status
[15:51:46.044] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:46.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:23:0) after 1m0s
[15:52:46.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:23:0)
[15:52:46.104] Timer tick, asking Buildbucket for the build status
[15:52:46.243] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:46.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:24:0) after 1m0s
[15:53:46.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:24:0)
[15:53:46.324] Timer tick, asking Buildbucket for the build status
[15:53:48.726] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:48.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:25:0) after 1m0s
[15:54:48.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:25:0)
[15:54:48.748] Timer tick, asking Buildbucket for the build status
[15:54:48.886] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:48.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:26:0) after 1m0s
[15:55:48.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:26:0)
[15:55:48.895] Timer tick, asking Buildbucket for the build status
[15:55:48.998] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:48.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:27:0) after 1m0s
[15:56:49.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:27:0)
[15:56:49.024] Timer tick, asking Buildbucket for the build status
[15:56:49.280] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:49.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:28:0) after 1m0s
[15:57:49.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:28:0)
[15:57:49.301] Timer tick, asking Buildbucket for the build status
[15:57:49.425] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:49.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:29:0) after 1m0s
[15:58:49.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:29:0)
[15:58:49.565] Timer tick, asking Buildbucket for the build status
[15:58:49.749] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:49.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:30:0) after 1m0s
[15:59:49.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:30:0)
[15:59:49.780] Timer tick, asking Buildbucket for the build status
[15:59:49.915] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:49.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:31:0) after 1m0s
[16:00:49.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:31:0)
[16:00:49.999] Timer tick, asking Buildbucket for the build status
[16:00:50.390] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:50.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:32:0) after 1m0s
[16:01:50.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:32:0)
[16:01:50.595] Timer tick, asking Buildbucket for the build status
[16:01:51.178] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:51.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:33:0) after 1m0s
[16:02:51.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:33:0)
[16:02:51.195] Timer tick, asking Buildbucket for the build status
[16:02:51.427] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:51.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:34:0) after 1m0s
[16:03:51.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:34:0)
[16:03:51.468] Timer tick, asking Buildbucket for the build status
[16:03:52.646] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:52.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:35:0) after 1m0s
[16:04:52.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:35:0)
[16:04:52.754] Timer tick, asking Buildbucket for the build status
[16:04:52.825] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:52.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:36:0) after 1m0s
[16:05:52.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:36:0)
[16:05:52.979] Timer tick, asking Buildbucket for the build status
[16:05:53.085] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:53.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:37:0) after 1m0s
[16:06:53.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:37:0)
[16:06:53.198] Timer tick, asking Buildbucket for the build status
[16:06:53.333] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:53.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:38:0) after 1m0s
[16:07:53.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:38:0)
[16:07:53.352] Timer tick, asking Buildbucket for the build status
[16:07:53.937] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:53.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:39:0) after 1m0s
[16:08:54.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:39:0)
[16:08:54.059] Timer tick, asking Buildbucket for the build status
[16:08:55.174] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:55.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:40:0) after 1m0s
[16:09:55.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:40:0)
[16:09:55.192] Timer tick, asking Buildbucket for the build status
[16:09:57.137] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:57.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:41:0) after 1m0s
[16:10:57.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:41:0)
[16:10:57.175] Timer tick, asking Buildbucket for the build status
[16:10:57.338] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:57.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:42:0) after 1m0s
[16:11:57.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:42:0)
[16:11:57.371] Timer tick, asking Buildbucket for the build status
[16:11:57.474] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:57.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:43:0) after 1m0s
[16:12:57.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:43:0)
[16:12:57.545] Timer tick, asking Buildbucket for the build status
[16:12:57.678] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:57.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:44:0) after 1m0s
[16:13:57.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:44:0)
[16:13:57.710] Timer tick, asking Buildbucket for the build status
[16:13:57.981] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:57.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:45:0) after 1m0s
[16:14:58.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:45:0)
[16:14:58.173] Timer tick, asking Buildbucket for the build status
[16:14:58.309] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:58.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:46:0) after 1m0s
[16:15:58.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:46:0)
[16:15:58.390] Timer tick, asking Buildbucket for the build status
[16:15:58.596] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:58.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:47:0) after 1m0s
[16:16:58.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:47:0)
[16:16:58.684] Timer tick, asking Buildbucket for the build status
[16:16:58.931] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:58.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:48:0) after 1m0s
[16:17:59.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:48:0)
[16:17:59.009] Timer tick, asking Buildbucket for the build status
[16:18:00.309] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:00.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:49:0) after 1m0s
[16:19:00.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:49:0)
[16:19:00.317] Timer tick, asking Buildbucket for the build status
[16:19:00.935] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:00.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:50:0) after 1m0s
[16:20:02.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:50:0)
[16:20:02.197] Timer tick, asking Buildbucket for the build status
[16:20:02.560] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:02.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:51:0) after 1m0s
[16:21:02.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:51:0)
[16:21:02.682] Timer tick, asking Buildbucket for the build status
[16:21:03.193] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:03.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:52:0) after 1m0s
[16:22:03.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:52:0)
[16:22:03.237] Timer tick, asking Buildbucket for the build status
[16:22:03.572] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:03.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:53:0) after 1m0s
[16:23:03.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:53:0)
[16:23:03.672] Timer tick, asking Buildbucket for the build status
[16:23:03.867] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:03.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:54:0) after 1m0s
[16:24:04.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:54:0)
[16:24:04.016] Timer tick, asking Buildbucket for the build status
[16:24:04.232] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:04.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:55:0) after 1m0s
[16:25:04.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:55:0)
[16:25:04.313] Timer tick, asking Buildbucket for the build status
[16:25:04.617] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:04.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:56:0) after 1m0s
[16:26:04.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:56:0)
[16:26:04.846] Timer tick, asking Buildbucket for the build status
[16:26:05.151] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:05.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:57:0) after 1m0s
[16:27:05.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:57:0)
[16:27:05.291] Timer tick, asking Buildbucket for the build status
[16:27:05.358] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:05.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:58:0) after 1m0s
[16:28:05.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:58:0)
[16:28:05.430] Timer tick, asking Buildbucket for the build status
[16:28:05.518] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:05.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:59:0) after 1m0s
[16:29:05.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:59:0)
[16:29:05.683] Timer tick, asking Buildbucket for the build status
[16:29:08.338] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:08.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:60:0) after 1m0s
[16:30:08.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:60:0)
[16:30:08.358] Timer tick, asking Buildbucket for the build status
[16:30:09.291] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:09.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:61:0) after 1m0s
[16:31:09.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:61:0)
[16:31:09.397] Timer tick, asking Buildbucket for the build status
[16:31:09.545] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:09.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:62:0) after 1m0s
[16:32:09.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:62:0)
[16:32:09.789] Timer tick, asking Buildbucket for the build status
[16:32:09.950] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:09.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:63:0) after 1m0s
[16:33:09.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:63:0)
[16:33:09.999] Timer tick, asking Buildbucket for the build status
[16:33:10.308] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:10.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:64:0) after 1m0s
[16:34:10.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:64:0)
[16:34:10.291] Timer tick, asking Buildbucket for the build status
[16:34:10.403] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:10.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:65:0) after 1m0s
[16:35:10.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:65:0)
[16:35:10.481] Timer tick, asking Buildbucket for the build status
[16:35:10.550] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:10.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:66:0) after 1m0s
[16:36:10.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:66:0)
[16:36:10.680] Timer tick, asking Buildbucket for the build status
[16:36:10.770] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:10.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:67:0) after 1m0s
[16:37:10.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:67:0)
[16:37:10.844] Timer tick, asking Buildbucket for the build status
[16:37:11.262] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:11.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:68:0) after 1m0s
[16:38:11.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:68:0)
[16:38:11.295] Timer tick, asking Buildbucket for the build status
[16:38:11.749] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:11.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:69:0) after 1m0s
[16:39:11.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:69:0)
[16:39:11.929] Timer tick, asking Buildbucket for the build status
[16:39:12.951] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:12.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:70:0) after 1m0s
[16:40:12.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:70:0)
[16:40:12.992] Timer tick, asking Buildbucket for the build status
[16:40:13.128] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:13.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:71:0) after 1m0s
[16:41:13.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:71:0)
[16:41:13.188] Timer tick, asking Buildbucket for the build status
[16:41:13.595] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:13.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:72:0) after 1m0s
[16:42:13.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:72:0)
[16:42:13.639] Timer tick, asking Buildbucket for the build status
[16:42:13.840] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:13.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:73:0) after 1m0s
[16:43:13.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:73:0)
[16:43:13.959] Timer tick, asking Buildbucket for the build status
[16:43:14.102] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:14.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:74:0) after 1m0s
[16:44:14.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:74:0)
[16:44:14.197] Timer tick, asking Buildbucket for the build status
[16:44:14.571] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:14.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:75:0) after 1m0s
[16:45:14.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:75:0)
[16:45:14.611] Timer tick, asking Buildbucket for the build status
[16:45:14.775] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:14.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:76:0) after 1m0s
[16:46:15.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:76:0)
[16:46:15.038] Timer tick, asking Buildbucket for the build status
[16:46:15.199] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:15.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:77:0) after 1m0s
[16:47:15.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:77:0)
[16:47:15.226] Timer tick, asking Buildbucket for the build status
[16:47:15.552] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:15.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:78:0) after 1m0s
[16:48:15.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:78:0)
[16:48:15.699] Timer tick, asking Buildbucket for the build status
[16:48:15.777] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:15.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:79:0) after 1m0s
[16:49:15.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:79:0)
[16:49:15.814] Timer tick, asking Buildbucket for the build status
[16:49:15.996] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:15.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:80:0) after 1m0s
[16:50:16.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:80:0)
[16:50:16.082] Timer tick, asking Buildbucket for the build status
[16:50:16.366] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:16.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:81:0) after 1m0s
[16:51:16.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:81:0)
[16:51:16.924] Timer tick, asking Buildbucket for the build status
[16:51:17.083] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:17.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:82:0) after 1m0s
[16:52:17.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:82:0)
[16:52:17.523] Timer tick, asking Buildbucket for the build status
[16:52:17.593] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:17.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:83:0) after 1m0s
[16:53:17.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:83:0)
[16:53:17.753] Timer tick, asking Buildbucket for the build status
[16:53:17.944] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:17.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:84:0) after 1m0s
[16:54:18.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:84:0)
[16:54:18.135] Timer tick, asking Buildbucket for the build status
[16:54:18.697] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:18.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:85:0) after 1m0s
[16:55:18.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:85:0)
[16:55:18.787] Timer tick, asking Buildbucket for the build status
[16:55:18.962] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:18.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:86:0) after 1m0s
[16:56:19.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:86:0)
[16:56:19.033] Timer tick, asking Buildbucket for the build status
[16:56:19.239] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:19.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:87:0) after 1m0s
[16:57:19.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:87:0)
[16:57:19.566] Timer tick, asking Buildbucket for the build status
[16:57:19.787] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:19.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:88:0) after 1m0s
[16:58:20.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:88:0)
[16:58:20.277] Timer tick, asking Buildbucket for the build status
[16:58:20.497] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:20.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:89:0) after 1m0s
[16:59:20.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:89:0)
[16:59:20.648] Timer tick, asking Buildbucket for the build status
[16:59:20.755] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:20.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:90:0) after 1m0s
[17:00:20.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:90:0)
[17:00:20.996] Timer tick, asking Buildbucket for the build status
[17:00:21.084] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:21.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:91:0) after 1m0s
[17:01:21.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:91:0)
[17:01:21.831] Timer tick, asking Buildbucket for the build status
[17:01:27.094] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:27.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:92:0) after 1m0s
[17:02:27.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:92:0)
[17:02:27.858] Timer tick, asking Buildbucket for the build status
[17:02:28.679] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:28.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:93:0) after 1m0s
[17:03:29.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:93:0)
[17:03:29.243] Timer tick, asking Buildbucket for the build status
[17:03:31.378] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:31.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:94:0) after 1m0s
[17:04:31.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:94:0)
[17:04:31.448] Timer tick, asking Buildbucket for the build status
[17:04:31.747] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:31.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:95:0) after 1m0s
[17:05:31.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:95:0)
[17:05:31.849] Timer tick, asking Buildbucket for the build status
[17:05:32.022] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:32.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:96:0) after 1m0s
[17:06:32.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:96:0)
[17:06:32.051] Timer tick, asking Buildbucket for the build status
[17:06:32.225] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:32.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:97:0) after 1m0s
[17:07:32.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:97:0)
[17:07:32.314] Timer tick, asking Buildbucket for the build status
[17:07:32.393] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:32.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:98:0) after 1m0s
[17:08:32.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:98:0)
[17:08:32.532] Timer tick, asking Buildbucket for the build status
[17:08:32.750] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:32.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:99:0) after 1m0s
[17:09:32.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:99:0)
[17:09:32.899] Timer tick, asking Buildbucket for the build status
[17:09:33.292] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:33.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:100:0) after 1m0s
[17:10:33.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:100:0)
[17:10:33.510] Timer tick, asking Buildbucket for the build status
[17:10:33.621] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:33.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:101:0) after 1m0s
[17:11:33.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:101:0)
[17:11:33.770] Timer tick, asking Buildbucket for the build status
[17:11:33.929] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:33.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:102:0) after 1m0s
[17:12:34.170] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:102:0)
[17:12:34.170] Timer tick, asking Buildbucket for the build status
[17:12:34.297] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:34.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:103:0) after 1m0s
[17:13:34.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:103:0)
[17:13:34.359] Timer tick, asking Buildbucket for the build status
[17:13:34.599] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:34.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:104:0) after 1m0s
[17:14:34.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:104:0)
[17:14:34.762] Timer tick, asking Buildbucket for the build status
[17:14:34.864] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:34.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:105:0) after 1m0s
[17:15:34.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:105:0)
[17:15:34.995] Timer tick, asking Buildbucket for the build status
[17:15:35.107] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:35.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:106:0) after 1m0s
[17:16:35.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:106:0)
[17:16:35.217] Timer tick, asking Buildbucket for the build status
[17:16:36.163] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:36.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:107:0) after 1m0s
[17:17:36.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:107:0)
[17:17:36.326] Timer tick, asking Buildbucket for the build status
[17:17:36.553] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:36.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:108:0) after 1m0s
[17:18:36.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:108:0)
[17:18:36.639] Timer tick, asking Buildbucket for the build status
[17:18:37.258] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:37.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:109:0) after 1m0s
[17:19:37.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:109:0)
[17:19:37.316] Timer tick, asking Buildbucket for the build status
[17:19:37.406] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:37.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:110:0) after 1m0s
[17:20:37.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:110:0)
[17:20:37.530] Timer tick, asking Buildbucket for the build status
[17:20:37.710] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:37.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:111:0) after 1m0s
[17:21:37.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:111:0)
[17:21:37.799] Timer tick, asking Buildbucket for the build status
[17:21:37.898] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:37.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:112:0) after 1m0s
[17:22:38.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:112:0)
[17:22:38.035] Timer tick, asking Buildbucket for the build status
[17:22:38.110] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:38.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:113:0) after 1m0s
[17:23:38.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:113:0)
[17:23:38.252] Timer tick, asking Buildbucket for the build status
[17:23:38.342] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:38.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:114:0) after 1m0s
[17:24:38.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:114:0)
[17:24:38.390] Timer tick, asking Buildbucket for the build status
[17:24:38.597] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:38.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:115:0) after 1m0s
[17:25:38.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:115:0)
[17:25:38.870] Timer tick, asking Buildbucket for the build status
[17:25:40.021] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:40.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:116:0) after 1m0s
[17:26:40.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:116:0)
[17:26:40.072] Timer tick, asking Buildbucket for the build status
[17:26:40.148] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:40.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:117:0) after 1m0s
[17:27:40.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:117:0)
[17:27:40.224] Timer tick, asking Buildbucket for the build status
[17:27:40.686] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:40.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:118:0) after 1m0s
[17:28:40.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:118:0)
[17:28:40.745] Timer tick, asking Buildbucket for the build status
[17:28:41.088] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:41.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:119:0) after 1m0s
[17:29:41.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:119:0)
[17:29:41.099] Timer tick, asking Buildbucket for the build status
[17:29:41.168] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:41.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:120:0) after 1m0s
[17:30:41.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:120:0)
[17:30:41.287] Timer tick, asking Buildbucket for the build status
[17:30:41.601] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:41.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:121:0) after 1m0s
[17:31:41.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:121:0)
[17:31:41.675] Timer tick, asking Buildbucket for the build status
[17:31:41.860] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:41.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:122:0) after 1m0s
[17:32:41.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:122:0)
[17:32:41.883] Timer tick, asking Buildbucket for the build status
[17:32:41.953] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:41.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:123:0) after 1m0s
[17:33:41.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:123:0)
[17:33:41.975] Timer tick, asking Buildbucket for the build status
[17:33:43.335] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:43.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:124:0) after 1m0s
[17:34:43.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:124:0)
[17:34:43.362] Timer tick, asking Buildbucket for the build status
[17:34:43.774] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:43.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:125:0) after 1m0s
[17:35:43.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:125:0)
[17:35:43.833] Timer tick, asking Buildbucket for the build status
[17:35:44.082] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:44.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:126:0) after 1m0s
[17:36:44.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:126:0)
[17:36:44.174] Timer tick, asking Buildbucket for the build status
[17:36:44.443] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:44.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:127:0) after 1m0s
[17:37:44.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:127:0)
[17:37:44.540] Timer tick, asking Buildbucket for the build status
[17:37:44.622] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:44.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:128:0) after 1m0s
[17:38:44.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:128:0)
[17:38:44.739] Timer tick, asking Buildbucket for the build status
[17:38:45.990] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:45.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:129:0) after 1m0s
[17:39:45.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:129:0)
[17:39:45.986] Timer tick, asking Buildbucket for the build status
[17:39:46.359] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:46.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:130:0) after 1m0s
[17:40:46.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:130:0)
[17:40:46.444] Timer tick, asking Buildbucket for the build status
[17:40:46.582] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:46.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:131:0) after 1m0s
[17:41:46.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:131:0)
[17:41:46.596] Timer tick, asking Buildbucket for the build status
[17:41:46.846] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:46.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:132:0) after 1m0s
[17:42:46.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:132:0)
[17:42:46.964] Timer tick, asking Buildbucket for the build status
[17:42:47.314] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:47.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:133:0) after 1m0s
[17:43:47.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:133:0)
[17:43:47.375] Timer tick, asking Buildbucket for the build status
[17:43:48.199] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:48.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:134:0) after 1m0s
[17:44:48.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:134:0)
[17:44:48.223] Timer tick, asking Buildbucket for the build status
[17:44:48.349] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:48.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:135:0) after 1m0s
[17:45:48.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:135:0)
[17:45:48.426] Timer tick, asking Buildbucket for the build status
[17:45:48.614] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:48.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:136:0) after 1m0s
[17:46:48.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:136:0)
[17:46:48.654] Timer tick, asking Buildbucket for the build status
[17:46:48.736] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:48.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:137:0) after 1m0s
[17:47:48.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:137:0)
[17:47:48.818] Timer tick, asking Buildbucket for the build status
[17:47:48.941] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:48.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:138:0) after 1m0s
[17:48:49.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:138:0)
[17:48:49.047] Timer tick, asking Buildbucket for the build status
[17:48:49.721] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:49.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:139:0) after 1m0s
[17:49:49.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:139:0)
[17:49:49.974] Timer tick, asking Buildbucket for the build status
[17:49:50.173] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:50.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:140:0) after 1m0s
[17:50:50.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:140:0)
[17:50:50.496] Timer tick, asking Buildbucket for the build status
[17:50:50.590] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:50.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:141:0) after 1m0s
[17:51:50.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:141:0)
[17:51:50.777] Timer tick, asking Buildbucket for the build status
[17:51:50.827] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:50.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:142:0) after 1m0s
[17:52:51.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:142:0)
[17:52:51.085] Timer tick, asking Buildbucket for the build status
[17:52:51.374] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:51.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:143:0) after 1m0s
[17:53:52.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:143:0)
[17:53:52.815] Timer tick, asking Buildbucket for the build status
[17:53:53.766] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:53.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:144:0) after 1m0s
[17:54:53.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:144:0)
[17:54:53.846] Timer tick, asking Buildbucket for the build status
[17:54:53.986] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:53.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:145:0) after 1m0s
[17:55:55.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:145:0)
[17:55:55.606] Timer tick, asking Buildbucket for the build status
[17:55:55.709] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:55.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:146:0) after 1m0s
[17:56:55.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:146:0)
[17:56:55.817] Timer tick, asking Buildbucket for the build status
[17:56:59.103] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:59.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:147:0) after 1m0s
[17:57:59.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:147:0)
[17:57:59.128] Timer tick, asking Buildbucket for the build status
[17:57:59.225] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:59.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:148:0) after 1m0s
[17:58:59.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:148:0)
[17:58:59.356] Timer tick, asking Buildbucket for the build status
[17:58:59.532] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:59.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:149:0) after 1m0s
[17:59:59.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:149:0)
[17:59:59.586] Timer tick, asking Buildbucket for the build status
[18:00:00.281] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:00.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:150:0) after 1m0s
[18:01:00.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:150:0)
[18:01:00.396] Timer tick, asking Buildbucket for the build status
[18:01:00.478] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:00.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:151:0) after 1m0s
[18:02:00.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:151:0)
[18:02:00.555] Timer tick, asking Buildbucket for the build status
[18:02:00.754] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:00.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:152:0) after 1m0s
[18:03:00.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:152:0)
[18:03:00.897] Timer tick, asking Buildbucket for the build status
[18:03:02.004] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:02.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:153:0) after 1m0s
[18:04:02.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:153:0)
[18:04:02.590] Timer tick, asking Buildbucket for the build status
[18:04:02.820] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:02.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:154:0) after 1m0s
[18:05:03.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:154:0)
[18:05:03.396] Timer tick, asking Buildbucket for the build status
[18:05:04.626] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:04.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:155:0) after 1m0s
[18:06:04.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:155:0)
[18:06:04.665] Timer tick, asking Buildbucket for the build status
[18:06:05.076] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:05.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:156:0) after 1m0s
[18:07:05.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:156:0)
[18:07:05.331] Timer tick, asking Buildbucket for the build status
[18:07:05.638] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:05.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:157:0) after 1m0s
[18:08:05.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:157:0)
[18:08:05.734] Timer tick, asking Buildbucket for the build status
[18:08:05.845] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:05.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:158:0) after 1m0s
[18:09:05.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:158:0)
[18:09:05.988] Timer tick, asking Buildbucket for the build status
[18:09:06.154] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:06.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:159:0) after 1m0s
[18:10:06.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:159:0)
[18:10:06.718] Timer tick, asking Buildbucket for the build status
[18:10:06.955] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:06.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:160:0) after 1m0s
[18:11:07.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:160:0)
[18:11:07.685] Timer tick, asking Buildbucket for the build status
[18:11:07.869] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:07.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:161:0) after 1m0s
[18:12:08.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:161:0)
[18:12:08.165] Timer tick, asking Buildbucket for the build status
[18:12:08.270] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:08.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:162:0) after 1m0s
[18:13:08.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:162:0)
[18:13:08.504] Timer tick, asking Buildbucket for the build status
[18:13:08.586] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:08.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:163:0) after 1m0s
[18:14:08.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:163:0)
[18:14:08.836] Timer tick, asking Buildbucket for the build status
[18:14:10.161] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:10.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:164:0) after 1m0s
[18:15:10.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:164:0)
[18:15:10.239] Timer tick, asking Buildbucket for the build status
[18:15:10.728] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:10.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:165:0) after 1m0s
[18:16:10.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:165:0)
[18:16:10.887] Timer tick, asking Buildbucket for the build status
[18:16:10.994] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:10.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:166:0) after 1m0s
[18:17:11.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:166:0)
[18:17:11.079] Timer tick, asking Buildbucket for the build status
[18:17:12.104] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:12.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:167:0) after 1m0s
[18:18:12.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:167:0)
[18:18:12.196] Timer tick, asking Buildbucket for the build status
[18:18:12.364] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:12.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:168:0) after 1m0s
[18:19:12.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:168:0)
[18:19:12.392] Timer tick, asking Buildbucket for the build status
[18:19:12.470] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:12.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:169:0) after 1m0s
[18:20:12.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:169:0)
[18:20:12.575] Timer tick, asking Buildbucket for the build status
[18:20:12.847] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:12.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:170:0) after 1m0s
[18:21:12.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:170:0)
[18:21:12.895] Timer tick, asking Buildbucket for the build status
[18:21:13.571] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:13.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:171:0) after 1m0s
[18:22:13.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:171:0)
[18:22:13.688] Timer tick, asking Buildbucket for the build status
[18:22:13.895] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:13.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:172:0) after 1m0s
[18:23:13.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:172:0)
[18:23:13.950] Timer tick, asking Buildbucket for the build status
[18:23:15.079] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:15.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:173:0) after 1m0s
[18:24:15.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:173:0)
[18:24:15.093] Timer tick, asking Buildbucket for the build status
[18:24:15.732] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:15.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:174:0) after 1m0s
[18:25:15.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:174:0)
[18:25:15.794] Timer tick, asking Buildbucket for the build status
[18:25:16.251] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:16.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:175:0) after 1m0s
[18:26:16.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:175:0)
[18:26:16.426] Timer tick, asking Buildbucket for the build status
[18:26:16.502] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:16.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:176:0) after 1m0s
[18:27:16.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:176:0)
[18:27:16.532] Timer tick, asking Buildbucket for the build status
[18:27:16.923] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:16.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:177:0) after 1m0s
[18:28:16.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:177:0)
[18:28:16.980] Timer tick, asking Buildbucket for the build status
[18:28:17.579] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:17.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:178:0) after 1m0s
[18:29:17.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:178:0)
[18:29:17.605] Timer tick, asking Buildbucket for the build status
[18:29:17.846] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:17.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:179:0) after 1m0s
[18:30:17.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:179:0)
[18:30:17.986] Timer tick, asking Buildbucket for the build status
[18:30:18.086] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:18.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:180:0) after 1m0s
[18:31:18.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:180:0)
[18:31:18.296] Timer tick, asking Buildbucket for the build status
[18:31:18.397] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:18.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:181:0) after 1m0s
[18:32:18.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:181:0)
[18:32:18.534] Timer tick, asking Buildbucket for the build status
[18:32:18.970] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:18.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:182:0) after 1m0s
[18:33:19.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:182:0)
[18:33:19.283] Timer tick, asking Buildbucket for the build status
[18:33:19.371] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:19.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:183:0) after 1m0s
[18:34:19.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:183:0)
[18:34:19.469] Timer tick, asking Buildbucket for the build status
[18:34:20.137] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:20.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:184:0) after 1m0s
[18:35:20.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:184:0)
[18:35:20.161] Timer tick, asking Buildbucket for the build status
[18:35:20.316] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:20.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:185:0) after 1m0s
[18:36:20.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:185:0)
[18:36:20.369] Timer tick, asking Buildbucket for the build status
[18:36:20.584] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:20.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:186:0) after 1m0s
[18:37:20.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:186:0)
[18:37:20.645] Timer tick, asking Buildbucket for the build status
[18:37:20.841] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:20.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:187:0) after 1m0s
[18:38:20.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:187:0)
[18:38:20.947] Timer tick, asking Buildbucket for the build status
[18:38:21.285] Build 8876689436816201808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:21.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042119498900538272:188:0) after 1m0s
[18:38:37.718] Received PubSub notification, asking Buildbucket for the build status
[18:38:40.688] Build 8876689436816201808: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:38:40.688] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1592937516518271",
    "created_by": "project:infra",
    "created_ts": "1592926291601456",
    "id": "8876689436816201808",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4180.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e1f4757d-7452-4e7f-8601-c8418a36e0ff\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4180.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-lg3n\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5218-123b763\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1592926475159292",
    "status": "COMPLETED",
    "status_changed_ts": "1592937517133366",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9042119498900538272",
      "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/8876689436816201808/+/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:4cfaa247dca1dc10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1592937517219939",
    "url": "https://ci.chromium.org/b/8876689436816201808",
    "utcnow_ts": "1592937520668434"
  }
}
[18:38:40.688] Invocation finished in 3h7m10.457865423s with status SUCCEEDED