LUCI Scheduler :: infra :: Build From Tarball

Status: SUCCEEDED

Triggered by: chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com

Duration: 3 hours

Actions:

Definition (rev ef1333c7bf2cf95d15a0ce92acf83d24bcd6c5ac)

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

Incoming triggers

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

Incoming properties

{
  "version": "85.0.4165.0"
}

Incoming tags

parent_buildername:publish_tarball
user_agent:recipe

Debug log (UTC)

[15:05:34.096] New invocation is queued and will start shortly
[15:05:34.096] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[15:05:35.201] Starting the invocation (attempt 1)
[15:05:35.249] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:05:35.249] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:05:35.249] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9043751876038283984",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4165.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"80178be1-fdbb-4342-a53b-f4f0404c43dc\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4165.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:9043751876038283984",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[15:05:35.814] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1591369535344256",
    "id": "8878321814065751360",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4165.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"80178be1-fdbb-4342-a53b-f4f0404c43dc\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4165.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1591369535564781",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043751876038283984",
      "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/8878321814065751360/+/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": "1591369535564909",
    "url": "https://ci.chromium.org/b/8878321814065751360",
    "utcnow_ts": "1591369535790828"
  }
}
[15:05:35.814] Task URL: https://ci.chromium.org/b/8878321814065751360
[15:05:35.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:2:0) after 1m0s
[15:06:35.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:2:0)
[15:06:35.874] Timer tick, asking Buildbucket for the build status
[15:06:36.074] Build 8878321814065751360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:06:36.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:3:0) after 1m0s
[15:07:36.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:3:0)
[15:07:36.060] Timer tick, asking Buildbucket for the build status
[15:07:36.549] Build 8878321814065751360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:07:36.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:4:0) after 1m0s
[15:08:36.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:4:0)
[15:08:36.571] Timer tick, asking Buildbucket for the build status
[15:08:37.237] Build 8878321814065751360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:08:37.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:5:0) after 1m0s
[15:09:37.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:5:0)
[15:09:37.241] Timer tick, asking Buildbucket for the build status
[15:09:37.347] Build 8878321814065751360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:09:37.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:6:0) after 1m0s
[15:10:37.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:6:0)
[15:10:37.436] Timer tick, asking Buildbucket for the build status
[15:10:37.606] Build 8878321814065751360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:10:37.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:7:0) after 1m0s
[15:11:37.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:7:0)
[15:11:37.600] Timer tick, asking Buildbucket for the build status
[15:11:37.800] Build 8878321814065751360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:11:37.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:8:0) after 1m0s
[15:12:37.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:8:0)
[15:12:37.960] Timer tick, asking Buildbucket for the build status
[15:12:38.872] Build 8878321814065751360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:12:38.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:9:0) after 1m0s
[15:13:38.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:9:0)
[15:13:38.925] Timer tick, asking Buildbucket for the build status
[15:13:39.314] Build 8878321814065751360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:13:39.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:10:0) after 1m0s
[15:14:39.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:10:0)
[15:14:39.333] Timer tick, asking Buildbucket for the build status
[15:14:39.464] Build 8878321814065751360: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:14:39.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:11:0) after 1m0s
[15:15:37.729] Received PubSub notification, asking Buildbucket for the build status
[15:15:37.912] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:39.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:11:0)
[15:15:39.569] Timer tick, asking Buildbucket for the build status
[15:15:39.727] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:39.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:13:0) after 1m0s
[15:16:39.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:13:0)
[15:16:39.768] Timer tick, asking Buildbucket for the build status
[15:16:39.966] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:39.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:14:0) after 1m0s
[15:17:40.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:14:0)
[15:17:40.084] Timer tick, asking Buildbucket for the build status
[15:17:40.493] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:40.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:15:0) after 1m0s
[15:18:40.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:15:0)
[15:18:40.582] Timer tick, asking Buildbucket for the build status
[15:18:41.347] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:41.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:16:0) after 1m0s
[15:19:41.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:16:0)
[15:19:41.367] Timer tick, asking Buildbucket for the build status
[15:19:41.958] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:41.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:17:0) after 1m0s
[15:20:41.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:17:0)
[15:20:41.983] Timer tick, asking Buildbucket for the build status
[15:20:42.451] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:42.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:18:0) after 1m0s
[15:21:42.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:18:0)
[15:21:42.550] Timer tick, asking Buildbucket for the build status
[15:21:42.769] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:42.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:19:0) after 1m0s
[15:22:42.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:19:0)
[15:22:42.801] Timer tick, asking Buildbucket for the build status
[15:22:42.939] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:42.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:20:0) after 1m0s
[15:23:42.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:20:0)
[15:23:42.995] Timer tick, asking Buildbucket for the build status
[15:23:43.227] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:43.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:21:0) after 1m0s
[15:24:43.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:21:0)
[15:24:43.255] Timer tick, asking Buildbucket for the build status
[15:24:44.333] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:44.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:22:0) after 1m0s
[15:25:44.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:22:0)
[15:25:44.389] Timer tick, asking Buildbucket for the build status
[15:25:45.430] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:45.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:23:0) after 1m0s
[15:26:45.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:23:0)
[15:26:45.514] Timer tick, asking Buildbucket for the build status
[15:26:46.325] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:46.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:24:0) after 1m0s
[15:27:46.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:24:0)
[15:27:46.349] Timer tick, asking Buildbucket for the build status
[15:27:46.553] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:46.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:25:0) after 1m0s
[15:28:46.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:25:0)
[15:28:46.634] Timer tick, asking Buildbucket for the build status
[15:28:47.182] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:47.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:26:0) after 1m0s
[15:29:47.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:26:0)
[15:29:47.238] Timer tick, asking Buildbucket for the build status
[15:29:47.441] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:47.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:27:0) after 1m0s
[15:30:47.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:27:0)
[15:30:47.428] Timer tick, asking Buildbucket for the build status
[15:30:47.687] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:47.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:28:0) after 1m0s
[15:31:47.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:28:0)
[15:31:47.721] Timer tick, asking Buildbucket for the build status
[15:31:48.064] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:48.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:29:0) after 1m0s
[15:32:48.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:29:0)
[15:32:48.093] Timer tick, asking Buildbucket for the build status
[15:32:48.244] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:48.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:30:0) after 1m0s
[15:33:48.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:30:0)
[15:33:48.266] Timer tick, asking Buildbucket for the build status
[15:33:48.396] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:48.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:31:0) after 1m0s
[15:34:48.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:31:0)
[15:34:48.430] Timer tick, asking Buildbucket for the build status
[15:34:48.595] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:48.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:32:0) after 1m0s
[15:35:48.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:32:0)
[15:35:48.716] Timer tick, asking Buildbucket for the build status
[15:35:48.908] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:48.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:33:0) after 1m0s
[15:36:48.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:33:0)
[15:36:48.907] Timer tick, asking Buildbucket for the build status
[15:36:49.173] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:49.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:34:0) after 1m0s
[15:37:49.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:34:0)
[15:37:49.270] Timer tick, asking Buildbucket for the build status
[15:37:49.396] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:49.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:35:0) after 1m0s
[15:38:49.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:35:0)
[15:38:49.452] Timer tick, asking Buildbucket for the build status
[15:38:49.664] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:49.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:36:0) after 1m0s
[15:39:49.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:36:0)
[15:39:49.812] Timer tick, asking Buildbucket for the build status
[15:39:50.036] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:50.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:37:0) after 1m0s
[15:40:50.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:37:0)
[15:40:50.082] Timer tick, asking Buildbucket for the build status
[15:40:50.491] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:50.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:38:0) after 1m0s
[15:41:50.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:38:0)
[15:41:50.512] Timer tick, asking Buildbucket for the build status
[15:41:50.668] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:50.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:39:0) after 1m0s
[15:42:50.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:39:0)
[15:42:50.699] Timer tick, asking Buildbucket for the build status
[15:42:51.208] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:51.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:40:0) after 1m0s
[15:43:51.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:40:0)
[15:43:51.230] Timer tick, asking Buildbucket for the build status
[15:43:51.557] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:51.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:41:0) after 1m0s
[15:44:51.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:41:0)
[15:44:51.596] Timer tick, asking Buildbucket for the build status
[15:44:51.823] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:51.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:42:0) after 1m0s
[15:45:51.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:42:0)
[15:45:51.870] Timer tick, asking Buildbucket for the build status
[15:45:52.362] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:52.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:43:0) after 1m0s
[15:46:52.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:43:0)
[15:46:52.479] Timer tick, asking Buildbucket for the build status
[15:46:52.876] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:52.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:44:0) after 1m0s
[15:47:52.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:44:0)
[15:47:52.905] Timer tick, asking Buildbucket for the build status
[15:47:53.496] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:53.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:45:0) after 1m0s
[15:48:53.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:45:0)
[15:48:53.561] Timer tick, asking Buildbucket for the build status
[15:48:54.295] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:54.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:46:0) after 1m0s
[15:49:54.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:46:0)
[15:49:54.309] Timer tick, asking Buildbucket for the build status
[15:49:54.671] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:54.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:47:0) after 1m0s
[15:50:54.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:47:0)
[15:50:54.768] Timer tick, asking Buildbucket for the build status
[15:50:54.920] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:54.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:48:0) after 1m0s
[15:51:54.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:48:0)
[15:51:54.971] Timer tick, asking Buildbucket for the build status
[15:51:55.442] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:55.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:49:0) after 1m0s
[15:52:55.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:49:0)
[15:52:55.451] Timer tick, asking Buildbucket for the build status
[15:52:55.899] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:55.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:50:0) after 1m0s
[15:53:56.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:50:0)
[15:53:56.095] Timer tick, asking Buildbucket for the build status
[15:53:56.247] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:56.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:51:0) after 1m0s
[15:54:56.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:51:0)
[15:54:56.308] Timer tick, asking Buildbucket for the build status
[15:54:56.575] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:56.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:52:0) after 1m0s
[15:55:56.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:52:0)
[15:55:56.611] Timer tick, asking Buildbucket for the build status
[15:55:56.792] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:56.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:53:0) after 1m0s
[15:56:56.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:53:0)
[15:56:56.824] Timer tick, asking Buildbucket for the build status
[15:56:57.036] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:57.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:54:0) after 1m0s
[15:57:57.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:54:0)
[15:57:57.158] Timer tick, asking Buildbucket for the build status
[15:57:57.492] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:57.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:55:0) after 1m0s
[15:58:57.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:55:0)
[15:58:57.546] Timer tick, asking Buildbucket for the build status
[15:58:57.704] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:57.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:56:0) after 1m0s
[15:59:57.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:56:0)
[15:59:57.818] Timer tick, asking Buildbucket for the build status
[15:59:58.019] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:58.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:57:0) after 1m0s
[16:00:58.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:57:0)
[16:00:58.047] Timer tick, asking Buildbucket for the build status
[16:00:58.483] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:58.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:58:0) after 1m0s
[16:01:58.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:58:0)
[16:01:58.516] Timer tick, asking Buildbucket for the build status
[16:01:58.683] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:58.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:59:0) after 1m0s
[16:02:58.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:59:0)
[16:02:58.778] Timer tick, asking Buildbucket for the build status
[16:02:58.930] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:58.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:60:0) after 1m0s
[16:03:58.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:60:0)
[16:03:58.954] Timer tick, asking Buildbucket for the build status
[16:03:59.109] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:59.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:61:0) after 1m0s
[16:04:59.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:61:0)
[16:04:59.156] Timer tick, asking Buildbucket for the build status
[16:04:59.566] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:59.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:62:0) after 1m0s
[16:05:59.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:62:0)
[16:05:59.618] Timer tick, asking Buildbucket for the build status
[16:05:59.998] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:59.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:63:0) after 1m0s
[16:07:00.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:63:0)
[16:07:00.042] Timer tick, asking Buildbucket for the build status
[16:07:00.530] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:00.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:64:0) after 1m0s
[16:08:00.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:64:0)
[16:08:00.562] Timer tick, asking Buildbucket for the build status
[16:08:00.902] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:00.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:65:0) after 1m0s
[16:09:00.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:65:0)
[16:09:00.929] Timer tick, asking Buildbucket for the build status
[16:09:01.248] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:01.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:66:0) after 1m0s
[16:10:01.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:66:0)
[16:10:01.665] Timer tick, asking Buildbucket for the build status
[16:10:01.872] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:01.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:67:0) after 1m0s
[16:11:01.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:67:0)
[16:11:01.928] Timer tick, asking Buildbucket for the build status
[16:11:02.124] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:02.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:68:0) after 1m0s
[16:12:02.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:68:0)
[16:12:02.134] Timer tick, asking Buildbucket for the build status
[16:12:02.514] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:02.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:69:0) after 1m0s
[16:13:03.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:69:0)
[16:13:03.321] Timer tick, asking Buildbucket for the build status
[16:13:03.538] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:03.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:70:0) after 1m0s
[16:14:03.524] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:70:0)
[16:14:03.524] Timer tick, asking Buildbucket for the build status
[16:14:04.535] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:04.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:71:0) after 1m0s
[16:15:05.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:71:0)
[16:15:05.118] Timer tick, asking Buildbucket for the build status
[16:15:06.914] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:06.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:72:0) after 1m0s
[16:16:06.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:72:0)
[16:16:06.935] Timer tick, asking Buildbucket for the build status
[16:16:07.155] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:07.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:73:0) after 1m0s
[16:17:07.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:73:0)
[16:17:07.161] Timer tick, asking Buildbucket for the build status
[16:17:07.609] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:07.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:74:0) after 1m0s
[16:18:07.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:74:0)
[16:18:07.694] Timer tick, asking Buildbucket for the build status
[16:18:08.008] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:08.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:75:0) after 1m0s
[16:19:08.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:75:0)
[16:19:08.088] Timer tick, asking Buildbucket for the build status
[16:19:08.279] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:08.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:76:0) after 1m0s
[16:20:08.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:76:0)
[16:20:08.342] Timer tick, asking Buildbucket for the build status
[16:20:09.193] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:09.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:77:0) after 1m0s
[16:21:09.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:77:0)
[16:21:09.227] Timer tick, asking Buildbucket for the build status
[16:21:09.451] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:09.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:78:0) after 1m0s
[16:22:09.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:78:0)
[16:22:09.470] Timer tick, asking Buildbucket for the build status
[16:22:10.492] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:10.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:79:0) after 1m0s
[16:23:10.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:79:0)
[16:23:10.562] Timer tick, asking Buildbucket for the build status
[16:23:10.802] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:10.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:80:0) after 1m0s
[16:24:10.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:80:0)
[16:24:10.836] Timer tick, asking Buildbucket for the build status
[16:24:11.536] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:11.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:81:0) after 1m0s
[16:25:11.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:81:0)
[16:25:11.572] Timer tick, asking Buildbucket for the build status
[16:25:12.684] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:12.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:82:0) after 1m0s
[16:26:12.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:82:0)
[16:26:12.761] Timer tick, asking Buildbucket for the build status
[16:26:12.912] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:12.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:83:0) after 1m0s
[16:27:12.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:83:0)
[16:27:12.988] Timer tick, asking Buildbucket for the build status
[16:27:13.171] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:13.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:84:0) after 1m0s
[16:28:13.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:84:0)
[16:28:13.227] Timer tick, asking Buildbucket for the build status
[16:28:13.404] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:13.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:85:0) after 1m0s
[16:29:13.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:85:0)
[16:29:13.473] Timer tick, asking Buildbucket for the build status
[16:29:13.922] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:13.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:86:0) after 1m0s
[16:30:13.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:86:0)
[16:30:13.954] Timer tick, asking Buildbucket for the build status
[16:30:15.474] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:15.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:87:0) after 1m0s
[16:31:15.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:87:0)
[16:31:15.578] Timer tick, asking Buildbucket for the build status
[16:31:15.861] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:15.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:88:0) after 1m0s
[16:32:15.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:88:0)
[16:32:15.930] Timer tick, asking Buildbucket for the build status
[16:32:16.101] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:16.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:89:0) after 1m0s
[16:33:16.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:89:0)
[16:33:16.082] Timer tick, asking Buildbucket for the build status
[16:33:17.853] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:17.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:90:0) after 1m0s
[16:34:17.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:90:0)
[16:34:17.888] Timer tick, asking Buildbucket for the build status
[16:34:18.362] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:18.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:91:0) after 1m0s
[16:35:18.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:91:0)
[16:35:18.408] Timer tick, asking Buildbucket for the build status
[16:35:18.540] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:18.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:92:0) after 1m0s
[16:36:18.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:92:0)
[16:36:18.649] Timer tick, asking Buildbucket for the build status
[16:36:19.241] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:19.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:93:0) after 1m0s
[16:37:19.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:93:0)
[16:37:19.363] Timer tick, asking Buildbucket for the build status
[16:37:19.771] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:19.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:94:0) after 1m0s
[16:38:19.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:94:0)
[16:38:19.817] Timer tick, asking Buildbucket for the build status
[16:38:19.969] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:19.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:95:0) after 1m0s
[16:39:20.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:95:0)
[16:39:20.025] Timer tick, asking Buildbucket for the build status
[16:39:20.675] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:20.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:96:0) after 1m0s
[16:40:20.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:96:0)
[16:40:20.847] Timer tick, asking Buildbucket for the build status
[16:40:21.357] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:21.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:97:0) after 1m0s
[16:41:21.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:97:0)
[16:41:21.425] Timer tick, asking Buildbucket for the build status
[16:41:21.855] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:21.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:98:0) after 1m0s
[16:42:21.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:98:0)
[16:42:21.891] Timer tick, asking Buildbucket for the build status
[16:42:22.067] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:22.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:99:0) after 1m0s
[16:43:22.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:99:0)
[16:43:22.117] Timer tick, asking Buildbucket for the build status
[16:43:23.165] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:23.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:100:0) after 1m0s
[16:44:23.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:100:0)
[16:44:23.196] Timer tick, asking Buildbucket for the build status
[16:44:23.353] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:23.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:101:0) after 1m0s
[16:45:23.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:101:0)
[16:45:23.460] Timer tick, asking Buildbucket for the build status
[16:45:23.902] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:23.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:102:0) after 1m0s
[16:46:23.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:102:0)
[16:46:23.912] Timer tick, asking Buildbucket for the build status
[16:46:24.543] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:24.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:103:0) after 1m0s
[16:47:24.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:103:0)
[16:47:24.587] Timer tick, asking Buildbucket for the build status
[16:47:24.719] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:24.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:104:0) after 1m0s
[16:48:24.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:104:0)
[16:48:24.750] Timer tick, asking Buildbucket for the build status
[16:48:25.110] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:25.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:105:0) after 1m0s
[16:49:25.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:105:0)
[16:49:25.160] Timer tick, asking Buildbucket for the build status
[16:49:25.369] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:25.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:106:0) after 1m0s
[16:50:25.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:106:0)
[16:50:25.406] Timer tick, asking Buildbucket for the build status
[16:50:25.740] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:25.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:107:0) after 1m0s
[16:51:25.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:107:0)
[16:51:25.813] Timer tick, asking Buildbucket for the build status
[16:51:26.196] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:26.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:108:0) after 1m0s
[16:52:26.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:108:0)
[16:52:26.261] Timer tick, asking Buildbucket for the build status
[16:52:26.442] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:26.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:109:0) after 1m0s
[16:53:26.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:109:0)
[16:53:26.527] Timer tick, asking Buildbucket for the build status
[16:53:27.820] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:27.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:110:0) after 1m0s
[16:54:27.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:110:0)
[16:54:27.908] Timer tick, asking Buildbucket for the build status
[16:54:28.308] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:28.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:111:0) after 1m0s
[16:55:28.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:111:0)
[16:55:28.392] Timer tick, asking Buildbucket for the build status
[16:55:28.528] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:28.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:112:0) after 1m0s
[16:56:28.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:112:0)
[16:56:28.617] Timer tick, asking Buildbucket for the build status
[16:56:28.739] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:28.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:113:0) after 1m0s
[16:57:28.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:113:0)
[16:57:28.806] Timer tick, asking Buildbucket for the build status
[16:57:29.055] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:29.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:114:0) after 1m0s
[16:58:29.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:114:0)
[16:58:29.166] Timer tick, asking Buildbucket for the build status
[16:58:29.312] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:29.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:115:0) after 1m0s
[16:59:29.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:115:0)
[16:59:29.361] Timer tick, asking Buildbucket for the build status
[16:59:29.480] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:29.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:116:0) after 1m0s
[17:00:29.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:116:0)
[17:00:29.569] Timer tick, asking Buildbucket for the build status
[17:00:29.878] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:29.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:117:0) after 1m0s
[17:01:29.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:117:0)
[17:01:29.905] Timer tick, asking Buildbucket for the build status
[17:01:30.082] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:30.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:118:0) after 1m0s
[17:02:30.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:118:0)
[17:02:30.162] Timer tick, asking Buildbucket for the build status
[17:02:30.646] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:30.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:119:0) after 1m0s
[17:03:30.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:119:0)
[17:03:30.673] Timer tick, asking Buildbucket for the build status
[17:03:31.012] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:31.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:120:0) after 1m0s
[17:04:31.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:120:0)
[17:04:31.208] Timer tick, asking Buildbucket for the build status
[17:04:31.672] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:31.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:121:0) after 1m0s
[17:05:31.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:121:0)
[17:05:31.710] Timer tick, asking Buildbucket for the build status
[17:05:32.087] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:32.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:122:0) after 1m0s
[17:06:32.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:122:0)
[17:06:32.163] Timer tick, asking Buildbucket for the build status
[17:06:32.382] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:32.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:123:0) after 1m0s
[17:07:32.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:123:0)
[17:07:32.490] Timer tick, asking Buildbucket for the build status
[17:07:32.680] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:32.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:124:0) after 1m0s
[17:08:32.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:124:0)
[17:08:32.717] Timer tick, asking Buildbucket for the build status
[17:08:33.175] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:33.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:125:0) after 1m0s
[17:09:33.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:125:0)
[17:09:33.264] Timer tick, asking Buildbucket for the build status
[17:09:33.527] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:33.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:126:0) after 1m0s
[17:10:33.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:126:0)
[17:10:33.530] Timer tick, asking Buildbucket for the build status
[17:10:33.900] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:33.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:127:0) after 1m0s
[17:11:33.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:127:0)
[17:11:33.885] Timer tick, asking Buildbucket for the build status
[17:11:34.342] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:34.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:128:0) after 1m0s
[17:12:34.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:128:0)
[17:12:34.558] Timer tick, asking Buildbucket for the build status
[17:12:34.713] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:34.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:129:0) after 1m0s
[17:13:34.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:129:0)
[17:13:34.794] Timer tick, asking Buildbucket for the build status
[17:13:37.757] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:37.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:130:0) after 1m0s
[17:14:37.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:130:0)
[17:14:37.931] Timer tick, asking Buildbucket for the build status
[17:14:38.073] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:38.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:131:0) after 1m0s
[17:15:38.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:131:0)
[17:15:38.279] Timer tick, asking Buildbucket for the build status
[17:15:39.890] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:39.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:132:0) after 1m0s
[17:16:40.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:132:0)
[17:16:40.039] Timer tick, asking Buildbucket for the build status
[17:16:40.183] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:40.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:133:0) after 1m0s
[17:17:40.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:133:0)
[17:17:40.413] Timer tick, asking Buildbucket for the build status
[17:17:40.885] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:40.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:134:0) after 1m0s
[17:18:40.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:134:0)
[17:18:40.985] Timer tick, asking Buildbucket for the build status
[17:18:41.166] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:41.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:135:0) after 1m0s
[17:19:41.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:135:0)
[17:19:41.499] Timer tick, asking Buildbucket for the build status
[17:19:41.901] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:41.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:136:0) after 1m0s
[17:20:42.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:136:0)
[17:20:42.249] Timer tick, asking Buildbucket for the build status
[17:20:43.097] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:43.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:137:0) after 1m0s
[17:21:43.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:137:0)
[17:21:43.253] Timer tick, asking Buildbucket for the build status
[17:21:43.665] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:43.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:138:0) after 1m0s
[17:22:43.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:138:0)
[17:22:43.685] Timer tick, asking Buildbucket for the build status
[17:22:44.046] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:44.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:139:0) after 1m0s
[17:23:44.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:139:0)
[17:23:44.404] Timer tick, asking Buildbucket for the build status
[17:23:44.619] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:44.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:140:0) after 1m0s
[17:24:44.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:140:0)
[17:24:44.905] Timer tick, asking Buildbucket for the build status
[17:24:46.916] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:46.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:141:0) after 1m0s
[17:25:47.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:141:0)
[17:25:47.006] Timer tick, asking Buildbucket for the build status
[17:25:47.274] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:47.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:142:0) after 1m0s
[17:26:47.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:142:0)
[17:26:47.396] Timer tick, asking Buildbucket for the build status
[17:26:47.782] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:47.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:143:0) after 1m0s
[17:27:47.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:143:0)
[17:27:47.930] Timer tick, asking Buildbucket for the build status
[17:27:48.193] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:48.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:144:0) after 1m0s
[17:28:48.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:144:0)
[17:28:48.198] Timer tick, asking Buildbucket for the build status
[17:28:49.512] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:49.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:145:0) after 1m0s
[17:29:49.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:145:0)
[17:29:49.603] Timer tick, asking Buildbucket for the build status
[17:29:49.748] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:49.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:146:0) after 1m0s
[17:30:49.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:146:0)
[17:30:49.817] Timer tick, asking Buildbucket for the build status
[17:30:50.261] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:50.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:147:0) after 1m0s
[17:31:50.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:147:0)
[17:31:50.366] Timer tick, asking Buildbucket for the build status
[17:31:50.540] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:50.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:148:0) after 1m0s
[17:32:50.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:148:0)
[17:32:50.606] Timer tick, asking Buildbucket for the build status
[17:32:50.814] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:50.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:149:0) after 1m0s
[17:33:50.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:149:0)
[17:33:50.919] Timer tick, asking Buildbucket for the build status
[17:33:51.301] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:51.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:150:0) after 1m0s
[17:34:51.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:150:0)
[17:34:51.378] Timer tick, asking Buildbucket for the build status
[17:34:51.498] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:51.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:151:0) after 1m0s
[17:35:51.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:151:0)
[17:35:51.612] Timer tick, asking Buildbucket for the build status
[17:35:52.438] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:52.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:152:0) after 1m0s
[17:36:52.578] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:152:0)
[17:36:52.578] Timer tick, asking Buildbucket for the build status
[17:36:52.716] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:52.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:153:0) after 1m0s
[17:37:52.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:153:0)
[17:37:52.913] Timer tick, asking Buildbucket for the build status
[17:37:53.242] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:53.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:154:0) after 1m0s
[17:38:53.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:154:0)
[17:38:53.374] Timer tick, asking Buildbucket for the build status
[17:38:55.595] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:55.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:155:0) after 1m0s
[17:39:55.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:155:0)
[17:39:55.698] Timer tick, asking Buildbucket for the build status
[17:39:58.382] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:58.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:156:0) after 1m0s
[17:40:58.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:156:0)
[17:40:58.393] Timer tick, asking Buildbucket for the build status
[17:40:58.871] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:58.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:157:0) after 1m0s
[17:41:58.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:157:0)
[17:41:58.912] Timer tick, asking Buildbucket for the build status
[17:41:59.225] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:59.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:158:0) after 1m0s
[17:42:59.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:158:0)
[17:42:59.512] Timer tick, asking Buildbucket for the build status
[17:42:59.738] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:59.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:159:0) after 1m0s
[17:43:59.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:159:0)
[17:43:59.897] Timer tick, asking Buildbucket for the build status
[17:44:00.173] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:00.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:160:0) after 1m0s
[17:45:00.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:160:0)
[17:45:00.236] Timer tick, asking Buildbucket for the build status
[17:45:00.437] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:00.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:161:0) after 1m0s
[17:46:00.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:161:0)
[17:46:00.518] Timer tick, asking Buildbucket for the build status
[17:46:00.970] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:00.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:162:0) after 1m0s
[17:47:03.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:162:0)
[17:47:03.495] Timer tick, asking Buildbucket for the build status
[17:47:03.687] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:03.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:163:0) after 1m0s
[17:48:03.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:163:0)
[17:48:03.749] Timer tick, asking Buildbucket for the build status
[17:48:04.299] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:04.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:164:0) after 1m0s
[17:49:04.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:164:0)
[17:49:04.309] Timer tick, asking Buildbucket for the build status
[17:49:04.531] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:04.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:165:0) after 1m0s
[17:50:04.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:165:0)
[17:50:04.627] Timer tick, asking Buildbucket for the build status
[17:50:04.808] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:04.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:166:0) after 1m0s
[17:51:04.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:166:0)
[17:51:04.882] Timer tick, asking Buildbucket for the build status
[17:51:05.189] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:05.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:167:0) after 1m0s
[17:52:05.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:167:0)
[17:52:05.359] Timer tick, asking Buildbucket for the build status
[17:52:05.510] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:05.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:168:0) after 1m0s
[17:53:05.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:168:0)
[17:53:05.539] Timer tick, asking Buildbucket for the build status
[17:53:05.722] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:05.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:169:0) after 1m0s
[17:54:05.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:169:0)
[17:54:05.849] Timer tick, asking Buildbucket for the build status
[17:54:06.362] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:06.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:170:0) after 1m0s
[17:55:06.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:170:0)
[17:55:06.541] Timer tick, asking Buildbucket for the build status
[17:55:07.333] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:07.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:171:0) after 1m0s
[17:56:07.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:171:0)
[17:56:07.367] Timer tick, asking Buildbucket for the build status
[17:56:07.594] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:07.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:172:0) after 1m0s
[17:57:07.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:172:0)
[17:57:07.738] Timer tick, asking Buildbucket for the build status
[17:57:07.910] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:07.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:173:0) after 1m0s
[17:58:08.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:173:0)
[17:58:08.043] Timer tick, asking Buildbucket for the build status
[17:58:08.205] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:08.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:174:0) after 1m0s
[17:59:08.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:174:0)
[17:59:08.258] Timer tick, asking Buildbucket for the build status
[17:59:08.398] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:08.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:175:0) after 1m0s
[18:00:08.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:175:0)
[18:00:08.576] Timer tick, asking Buildbucket for the build status
[18:00:09.011] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:09.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:176:0) after 1m0s
[18:01:09.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:176:0)
[18:01:09.149] Timer tick, asking Buildbucket for the build status
[18:01:09.345] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:09.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:177:0) after 1m0s
[18:02:09.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:177:0)
[18:02:09.382] Timer tick, asking Buildbucket for the build status
[18:02:09.723] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:09.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:178:0) after 1m0s
[18:03:09.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:178:0)
[18:03:09.857] Timer tick, asking Buildbucket for the build status
[18:03:10.241] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:10.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:179:0) after 1m0s
[18:04:10.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:179:0)
[18:04:10.274] Timer tick, asking Buildbucket for the build status
[18:04:10.711] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:10.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:180:0) after 1m0s
[18:05:10.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:180:0)
[18:05:10.833] Timer tick, asking Buildbucket for the build status
[18:05:11.075] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:11.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:181:0) after 1m0s
[18:06:11.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:181:0)
[18:06:11.098] Timer tick, asking Buildbucket for the build status
[18:06:11.250] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:11.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:182:0) after 1m0s
[18:07:11.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:182:0)
[18:07:11.314] Timer tick, asking Buildbucket for the build status
[18:07:11.602] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:11.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:183:0) after 1m0s
[18:08:11.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:183:0)
[18:08:11.639] Timer tick, asking Buildbucket for the build status
[18:08:11.773] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:11.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:184:0) after 1m0s
[18:09:11.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:184:0)
[18:09:11.841] Timer tick, asking Buildbucket for the build status
[18:09:11.979] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:11.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:185:0) after 1m0s
[18:10:12.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:185:0)
[18:10:12.032] Timer tick, asking Buildbucket for the build status
[18:10:12.838] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:12.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:186:0) after 1m0s
[18:11:12.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:186:0)
[18:11:12.917] Timer tick, asking Buildbucket for the build status
[18:11:13.048] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:13.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:187:0) after 1m0s
[18:12:13.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:187:0)
[18:12:13.152] Timer tick, asking Buildbucket for the build status
[18:12:14.002] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:14.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:188:0) after 1m0s
[18:13:14.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:188:0)
[18:13:14.064] Timer tick, asking Buildbucket for the build status
[18:13:14.216] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:14.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:189:0) after 1m0s
[18:14:14.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:189:0)
[18:14:14.275] Timer tick, asking Buildbucket for the build status
[18:14:14.456] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:14.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:190:0) after 1m0s
[18:15:14.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:190:0)
[18:15:14.554] Timer tick, asking Buildbucket for the build status
[18:15:14.733] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:14.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:191:0) after 1m0s
[18:16:15.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:191:0)
[18:16:15.056] Timer tick, asking Buildbucket for the build status
[18:16:15.203] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:15.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:192:0) after 1m0s
[18:17:15.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:192:0)
[18:17:15.353] Timer tick, asking Buildbucket for the build status
[18:17:17.001] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:17.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:193:0) after 1m0s
[18:18:17.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:193:0)
[18:18:17.134] Timer tick, asking Buildbucket for the build status
[18:18:17.457] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:17.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:194:0) after 1m0s
[18:19:17.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:194:0)
[18:19:17.537] Timer tick, asking Buildbucket for the build status
[18:19:17.723] Build 8878321814065751360: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:17.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043751876038283984:195:0) after 1m0s
[18:19:29.599] Received PubSub notification, asking Buildbucket for the build status
[18:19:29.791] Build 8878321814065751360: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:19:29.791] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1591381168272214",
    "created_by": "project:infra",
    "created_ts": "1591369535344256",
    "id": "8878321814065751360",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4165.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"80178be1-fdbb-4342-a53b-f4f0404c43dc\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4165.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"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-dd41\"], \"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\": [\"5168-d212e19\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1591370136724990",
    "status": "COMPLETED",
    "status_changed_ts": "1591381168934438",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043751876038283984",
      "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/8878321814065751360/+/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:4c9dd5a0661b9310",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1591381169079214",
    "url": "https://ci.chromium.org/b/8878321814065751360",
    "utcnow_ts": "1591381169779509"
  }
}
[18:19:29.791] Invocation finished in 3h13m55.711405272s with status SUCCEEDED