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

• parent_buildername:publish_tarball
• user_agent:recipe

[23:00:50.584] New invocation is queued and will start shortly
[23:00:50.584] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[23:00:55.973] Starting the invocation (attempt 1)
[23:00:56.071] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:00:56.072] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:00:56.072] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9041819438047857520",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4183.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"515c8850-754f-4e92-8b09-341ffd889e54\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4183.3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9041819438047857520",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[23:00:57.748] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1593212457168210",
    "id": "8876389370470767600",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4183.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"515c8850-754f-4e92-8b09-341ffd889e54\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4183.3\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1593212457523901",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9041819438047857520",
      "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/8876389370470767600/+/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": "1593212457524185",
    "url": "https://ci.chromium.org/b/8876389370470767600",
    "utcnow_ts": "1593212457733293"
  }
}
[23:00:57.748] Task URL: https://ci.chromium.org/b/8876389370470767600
[23:00:57.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:2:0) after 1m0s
[23:01:15.071] Received PubSub notification, asking Buildbucket for the build status
[23:01:15.197] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:58.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:2:0)
[23:01:58.046] Timer tick, asking Buildbucket for the build status
[23:01:58.284] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:58.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:4:0) after 1m0s
[23:02:58.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:4:0)
[23:02:58.438] Timer tick, asking Buildbucket for the build status
[23:02:58.690] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:58.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:5:0) after 1m0s
[23:03:58.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:5:0)
[23:03:58.817] Timer tick, asking Buildbucket for the build status
[23:03:59.245] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:59.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:6:0) after 1m0s
[23:04:59.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:6:0)
[23:04:59.270] Timer tick, asking Buildbucket for the build status
[23:05:01.859] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:01.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:7:0) after 1m0s
[23:06:02.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:7:0)
[23:06:02.226] Timer tick, asking Buildbucket for the build status
[23:06:02.355] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:02.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:8:0) after 1m0s
[23:07:02.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:8:0)
[23:07:02.471] Timer tick, asking Buildbucket for the build status
[23:07:02.697] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:02.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:9:0) after 1m0s
[23:08:02.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:9:0)
[23:08:02.828] Timer tick, asking Buildbucket for the build status
[23:08:03.236] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:03.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:10:0) after 1m0s
[23:09:03.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:10:0)
[23:09:03.334] Timer tick, asking Buildbucket for the build status
[23:09:03.562] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:03.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:11:0) after 1m0s
[23:10:03.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:11:0)
[23:10:03.657] Timer tick, asking Buildbucket for the build status
[23:10:04.255] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:04.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:12:0) after 1m0s
[23:11:04.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:12:0)
[23:11:04.349] Timer tick, asking Buildbucket for the build status
[23:11:04.554] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:04.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:13:0) after 1m0s
[23:12:04.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:13:0)
[23:12:04.562] Timer tick, asking Buildbucket for the build status
[23:12:04.857] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:04.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:14:0) after 1m0s
[23:13:04.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:14:0)
[23:13:04.903] Timer tick, asking Buildbucket for the build status
[23:13:05.113] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:05.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:15:0) after 1m0s
[23:14:05.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:15:0)
[23:14:05.152] Timer tick, asking Buildbucket for the build status
[23:14:05.327] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:05.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:16:0) after 1m0s
[23:15:05.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:16:0)
[23:15:05.358] Timer tick, asking Buildbucket for the build status
[23:15:05.864] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:05.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:17:0) after 1m0s
[23:16:05.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:17:0)
[23:16:05.887] Timer tick, asking Buildbucket for the build status
[23:16:06.054] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:06.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:18:0) after 1m0s
[23:17:06.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:18:0)
[23:17:06.105] Timer tick, asking Buildbucket for the build status
[23:17:06.286] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:06.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:19:0) after 1m0s
[23:18:06.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:19:0)
[23:18:06.468] Timer tick, asking Buildbucket for the build status
[23:18:06.771] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:06.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:20:0) after 1m0s
[23:19:06.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:20:0)
[23:19:06.851] Timer tick, asking Buildbucket for the build status
[23:19:07.028] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:07.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:21:0) after 1m0s
[23:20:07.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:21:0)
[23:20:07.168] Timer tick, asking Buildbucket for the build status
[23:20:07.306] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:07.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:22:0) after 1m0s
[23:21:07.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:22:0)
[23:21:07.395] Timer tick, asking Buildbucket for the build status
[23:21:07.498] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:07.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:23:0) after 1m0s
[23:22:07.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:23:0)
[23:22:07.669] Timer tick, asking Buildbucket for the build status
[23:22:07.853] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:07.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:24:0) after 1m0s
[23:23:08.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:24:0)
[23:23:08.049] Timer tick, asking Buildbucket for the build status
[23:23:08.251] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:08.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:25:0) after 1m0s
[23:24:08.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:25:0)
[23:24:08.474] Timer tick, asking Buildbucket for the build status
[23:24:08.635] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:08.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:26:0) after 1m0s
[23:25:08.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:26:0)
[23:25:08.937] Timer tick, asking Buildbucket for the build status
[23:25:09.066] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:09.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:27:0) after 1m0s
[23:26:09.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:27:0)
[23:26:09.431] Timer tick, asking Buildbucket for the build status
[23:26:09.542] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:09.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:28:0) after 1m0s
[23:27:09.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:28:0)
[23:27:09.986] Timer tick, asking Buildbucket for the build status
[23:27:10.157] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:10.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:29:0) after 1m0s
[23:28:10.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:29:0)
[23:28:10.469] Timer tick, asking Buildbucket for the build status
[23:28:10.679] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:10.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:30:0) after 1m0s
[23:29:10.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:30:0)
[23:29:10.740] Timer tick, asking Buildbucket for the build status
[23:29:11.174] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:11.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:31:0) after 1m0s
[23:30:11.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:31:0)
[23:30:11.193] Timer tick, asking Buildbucket for the build status
[23:30:11.624] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:11.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:32:0) after 1m0s
[23:31:12.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:32:0)
[23:31:12.521] Timer tick, asking Buildbucket for the build status
[23:31:12.689] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:12.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:33:0) after 1m0s
[23:32:12.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:33:0)
[23:32:12.878] Timer tick, asking Buildbucket for the build status
[23:32:13.041] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:13.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:34:0) after 1m0s
[23:33:13.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:34:0)
[23:33:13.239] Timer tick, asking Buildbucket for the build status
[23:33:14.589] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:14.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:35:0) after 1m0s
[23:34:14.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:35:0)
[23:34:14.838] Timer tick, asking Buildbucket for the build status
[23:34:15.243] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:15.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:36:0) after 1m0s
[23:35:15.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:36:0)
[23:35:15.276] Timer tick, asking Buildbucket for the build status
[23:35:15.600] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:15.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:37:0) after 1m0s
[23:36:15.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:37:0)
[23:36:15.810] Timer tick, asking Buildbucket for the build status
[23:36:15.967] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:15.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:38:0) after 1m0s
[23:37:16.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:38:0)
[23:37:16.069] Timer tick, asking Buildbucket for the build status
[23:37:16.273] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:16.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:39:0) after 1m0s
[23:38:16.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:39:0)
[23:38:16.510] Timer tick, asking Buildbucket for the build status
[23:38:16.683] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:16.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:40:0) after 1m0s
[23:39:16.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:40:0)
[23:39:16.917] Timer tick, asking Buildbucket for the build status
[23:39:17.047] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:17.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:41:0) after 1m0s
[23:40:17.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:41:0)
[23:40:17.149] Timer tick, asking Buildbucket for the build status
[23:40:17.262] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:17.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:42:0) after 1m0s
[23:41:17.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:42:0)
[23:41:17.752] Timer tick, asking Buildbucket for the build status
[23:41:17.930] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:17.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:43:0) after 1m0s
[23:42:18.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:43:0)
[23:42:18.134] Timer tick, asking Buildbucket for the build status
[23:42:18.308] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:18.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:44:0) after 1m0s
[23:43:18.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:44:0)
[23:43:18.580] Timer tick, asking Buildbucket for the build status
[23:43:19.065] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:19.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:45:0) after 1m0s
[23:44:19.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:45:0)
[23:44:19.484] Timer tick, asking Buildbucket for the build status
[23:44:20.052] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:20.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:46:0) after 1m0s
[23:45:20.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:46:0)
[23:45:20.101] Timer tick, asking Buildbucket for the build status
[23:45:20.466] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:20.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:47:0) after 1m0s
[23:46:20.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:47:0)
[23:46:20.643] Timer tick, asking Buildbucket for the build status
[23:46:20.779] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:20.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:48:0) after 1m0s
[23:47:21.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:48:0)
[23:47:21.024] Timer tick, asking Buildbucket for the build status
[23:47:21.340] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:21.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:49:0) after 1m0s
[23:48:21.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:49:0)
[23:48:21.591] Timer tick, asking Buildbucket for the build status
[23:48:21.963] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:21.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:50:0) after 1m0s
[23:49:21.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:50:0)
[23:49:21.966] Timer tick, asking Buildbucket for the build status
[23:49:24.414] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:24.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:51:0) after 1m0s
[23:50:24.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:51:0)
[23:50:24.513] Timer tick, asking Buildbucket for the build status
[23:50:27.853] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:27.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:52:0) after 1m0s
[23:51:28.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:52:0)
[23:51:28.039] Timer tick, asking Buildbucket for the build status
[23:51:28.276] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:28.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:53:0) after 1m0s
[23:52:28.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:53:0)
[23:52:28.331] Timer tick, asking Buildbucket for the build status
[23:52:28.824] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:28.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:54:0) after 1m0s
[23:53:29.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:54:0)
[23:53:29.695] Timer tick, asking Buildbucket for the build status
[23:53:29.953] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:29.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:55:0) after 1m0s
[23:54:29.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:55:0)
[23:54:29.962] Timer tick, asking Buildbucket for the build status
[23:54:30.703] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:30.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:56:0) after 1m0s
[23:55:30.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:56:0)
[23:55:30.733] Timer tick, asking Buildbucket for the build status
[23:55:30.929] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:30.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:57:0) after 1m0s
[23:56:30.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:57:0)
[23:56:30.972] Timer tick, asking Buildbucket for the build status
[23:56:31.276] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:31.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:58:0) after 1m0s
[23:57:31.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:58:0)
[23:57:31.293] Timer tick, asking Buildbucket for the build status
[23:57:31.425] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:31.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:59:0) after 1m0s
[23:58:31.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:59:0)
[23:58:31.470] Timer tick, asking Buildbucket for the build status
[23:58:31.700] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:31.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:60:0) after 1m0s
[23:59:33.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:60:0)
[23:59:33.402] Timer tick, asking Buildbucket for the build status
[23:59:34.668] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:34.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:61:0) after 1m0s
[00:00:34.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:61:0)
[00:00:34.692] Timer tick, asking Buildbucket for the build status
[00:00:34.915] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:34.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:62:0) after 1m0s
[00:01:35.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:62:0)
[00:01:35.029] Timer tick, asking Buildbucket for the build status
[00:01:35.183] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:35.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:63:0) after 1m0s
[00:02:35.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:63:0)
[00:02:35.224] Timer tick, asking Buildbucket for the build status
[00:02:35.405] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:35.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:64:0) after 1m0s
[00:03:35.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:64:0)
[00:03:35.455] Timer tick, asking Buildbucket for the build status
[00:03:35.808] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:35.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:65:0) after 1m0s
[00:04:35.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:65:0)
[00:04:35.842] Timer tick, asking Buildbucket for the build status
[00:04:42.962] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:42.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:66:0) after 1m0s
[00:05:43.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:66:0)
[00:05:43.048] Timer tick, asking Buildbucket for the build status
[00:05:43.207] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:43.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:67:0) after 1m0s
[00:06:43.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:67:0)
[00:06:43.252] Timer tick, asking Buildbucket for the build status
[00:06:43.559] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:43.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:68:0) after 1m0s
[00:07:44.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:68:0)
[00:07:44.377] Timer tick, asking Buildbucket for the build status
[00:07:44.541] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:44.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:69:0) after 1m0s
[00:08:48.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:69:0)
[00:08:48.311] Timer tick, asking Buildbucket for the build status
[00:08:48.484] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:48.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:70:0) after 1m0s
[00:09:50.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:70:0)
[00:09:50.425] Timer tick, asking Buildbucket for the build status
[00:09:50.706] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:50.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:71:0) after 1m0s
[00:10:51.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:71:0)
[00:10:51.671] Timer tick, asking Buildbucket for the build status
[00:10:51.790] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:51.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:72:0) after 1m0s
[00:11:53.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:72:0)
[00:11:53.794] Timer tick, asking Buildbucket for the build status
[00:11:53.937] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:53.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:73:0) after 1m0s
[00:12:54.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:73:0)
[00:12:54.593] Timer tick, asking Buildbucket for the build status
[00:12:54.815] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:54.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:74:0) after 1m0s
[00:13:55.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:74:0)
[00:13:55.054] Timer tick, asking Buildbucket for the build status
[00:13:55.222] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:55.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:75:0) after 1m0s
[00:14:55.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:75:0)
[00:14:55.457] Timer tick, asking Buildbucket for the build status
[00:14:57.289] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:57.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:76:0) after 1m0s
[00:15:57.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:76:0)
[00:15:57.357] Timer tick, asking Buildbucket for the build status
[00:15:57.603] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:57.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:77:0) after 1m0s
[00:16:57.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:77:0)
[00:16:57.691] Timer tick, asking Buildbucket for the build status
[00:16:57.849] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:57.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:78:0) after 1m0s
[00:17:57.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:78:0)
[00:17:57.878] Timer tick, asking Buildbucket for the build status
[00:17:58.112] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:58.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:79:0) after 1m0s
[00:18:58.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:79:0)
[00:18:58.239] Timer tick, asking Buildbucket for the build status
[00:18:58.425] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:58.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:80:0) after 1m0s
[00:19:58.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:80:0)
[00:19:58.460] Timer tick, asking Buildbucket for the build status
[00:19:58.952] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:58.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:81:0) after 1m0s
[00:20:58.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:81:0)
[00:20:58.998] Timer tick, asking Buildbucket for the build status
[00:20:59.138] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:59.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:82:0) after 1m0s
[00:21:59.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:82:0)
[00:21:59.153] Timer tick, asking Buildbucket for the build status
[00:21:59.466] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:59.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:83:0) after 1m0s
[00:22:59.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:83:0)
[00:22:59.496] Timer tick, asking Buildbucket for the build status
[00:22:59.867] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:59.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:84:0) after 1m0s
[00:23:59.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:84:0)
[00:23:59.908] Timer tick, asking Buildbucket for the build status
[00:24:00.350] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:00.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:85:0) after 1m0s
[00:25:01.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:85:0)
[00:25:01.497] Timer tick, asking Buildbucket for the build status
[00:25:01.723] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:01.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:86:0) after 1m0s
[00:26:01.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:86:0)
[00:26:01.804] Timer tick, asking Buildbucket for the build status
[00:26:01.929] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:01.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:87:0) after 1m0s
[00:27:02.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:87:0)
[00:27:02.062] Timer tick, asking Buildbucket for the build status
[00:27:02.693] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:02.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:88:0) after 1m0s
[00:28:02.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:88:0)
[00:28:02.776] Timer tick, asking Buildbucket for the build status
[00:28:03.168] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:03.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:89:0) after 1m0s
[00:29:03.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:89:0)
[00:29:03.226] Timer tick, asking Buildbucket for the build status
[00:29:03.743] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:03.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:90:0) after 1m0s
[00:30:03.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:90:0)
[00:30:03.768] Timer tick, asking Buildbucket for the build status
[00:30:05.495] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:05.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:91:0) after 1m0s
[00:33:08.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:91:0)
[00:33:08.322] Timer tick, asking Buildbucket for the build status
[00:33:08.601] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:08.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:92:0) after 1m0s
[00:34:08.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:92:0)
[00:34:08.631] Timer tick, asking Buildbucket for the build status
[00:34:08.839] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:08.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:93:0) after 1m0s
[00:35:08.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:93:0)
[00:35:08.890] Timer tick, asking Buildbucket for the build status
[00:35:09.067] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:09.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:94:0) after 1m0s
[00:36:09.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:94:0)
[00:36:09.131] Timer tick, asking Buildbucket for the build status
[00:36:09.342] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:09.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:95:0) after 1m0s
[00:37:10.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:95:0)
[00:37:10.498] Timer tick, asking Buildbucket for the build status
[00:37:10.976] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:10.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:96:0) after 1m0s
[00:38:11.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:96:0)
[00:38:11.120] Timer tick, asking Buildbucket for the build status
[00:38:11.315] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:11.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:97:0) after 1m0s
[00:39:11.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:97:0)
[00:39:11.471] Timer tick, asking Buildbucket for the build status
[00:39:12.277] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:12.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:98:0) after 1m0s
[00:40:12.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:98:0)
[00:40:12.354] Timer tick, asking Buildbucket for the build status
[00:40:12.573] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:12.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:99:0) after 1m0s
[00:41:13.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:99:0)
[00:41:13.549] Timer tick, asking Buildbucket for the build status
[00:41:13.748] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:13.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:100:0) after 1m0s
[00:42:14.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:100:0)
[00:42:14.833] Timer tick, asking Buildbucket for the build status
[00:42:15.005] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:15.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:101:0) after 1m0s
[00:43:16.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:101:0)
[00:43:16.279] Timer tick, asking Buildbucket for the build status
[00:43:16.688] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:16.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:102:0) after 1m0s
[00:44:19.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:102:0)
[00:44:19.702] Timer tick, asking Buildbucket for the build status
[00:44:19.950] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:19.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:103:0) after 1m0s
[00:45:20.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:103:0)
[00:45:20.088] Timer tick, asking Buildbucket for the build status
[00:45:20.308] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:20.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:104:0) after 1m0s
[00:46:20.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:104:0)
[00:46:20.359] Timer tick, asking Buildbucket for the build status
[00:46:20.705] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:20.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:105:0) after 1m0s
[00:47:20.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:105:0)
[00:47:20.735] Timer tick, asking Buildbucket for the build status
[00:47:21.186] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:21.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:106:0) after 1m0s
[00:48:21.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:106:0)
[00:48:21.283] Timer tick, asking Buildbucket for the build status
[00:48:21.537] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:21.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:107:0) after 1m0s
[00:49:21.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:107:0)
[00:49:21.592] Timer tick, asking Buildbucket for the build status
[00:49:24.850] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:24.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:108:0) after 1m0s
[00:50:24.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:108:0)
[00:50:24.887] Timer tick, asking Buildbucket for the build status
[00:50:25.056] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:25.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:109:0) after 1m0s
[00:51:25.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:109:0)
[00:51:25.099] Timer tick, asking Buildbucket for the build status
[00:51:25.224] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:25.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:110:0) after 1m0s
[00:52:25.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:110:0)
[00:52:25.234] Timer tick, asking Buildbucket for the build status
[00:52:25.347] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:25.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:111:0) after 1m0s
[00:53:25.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:111:0)
[00:53:25.375] Timer tick, asking Buildbucket for the build status
[00:53:25.586] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:25.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:112:0) after 1m0s
[00:54:25.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:112:0)
[00:54:25.816] Timer tick, asking Buildbucket for the build status
[00:54:26.418] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:26.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:113:0) after 1m0s
[00:55:31.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:113:0)
[00:55:31.007] Timer tick, asking Buildbucket for the build status
[00:55:31.179] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:31.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:114:0) after 1m0s
[00:56:35.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:114:0)
[00:56:35.681] Timer tick, asking Buildbucket for the build status
[00:56:35.822] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:35.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:115:0) after 1m0s
[00:57:35.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:115:0)
[00:57:35.851] Timer tick, asking Buildbucket for the build status
[00:57:35.976] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:35.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:116:0) after 1m0s
[00:58:36.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:116:0)
[00:58:36.154] Timer tick, asking Buildbucket for the build status
[00:58:36.291] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:36.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:117:0) after 1m0s
[00:59:36.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:117:0)
[00:59:36.741] Timer tick, asking Buildbucket for the build status
[00:59:39.807] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:39.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:118:0) after 1m0s
[01:00:39.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:118:0)
[01:00:39.848] Timer tick, asking Buildbucket for the build status
[01:00:40.943] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:40.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:119:0) after 1m0s
[01:01:41.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:119:0)
[01:01:41.087] Timer tick, asking Buildbucket for the build status
[01:01:41.282] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:41.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:120:0) after 1m0s
[01:02:42.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:120:0)
[01:02:42.101] Timer tick, asking Buildbucket for the build status
[01:02:42.355] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:42.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:121:0) after 1m0s
[01:03:42.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:121:0)
[01:03:42.420] Timer tick, asking Buildbucket for the build status
[01:03:42.560] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:42.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:122:0) after 1m0s
[01:04:42.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:122:0)
[01:04:42.611] Timer tick, asking Buildbucket for the build status
[01:04:48.381] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:48.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:123:0) after 1m0s
[01:05:49.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:123:0)
[01:05:49.038] Timer tick, asking Buildbucket for the build status
[01:05:49.226] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:49.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:124:0) after 1m0s
[01:06:49.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:124:0)
[01:06:49.481] Timer tick, asking Buildbucket for the build status
[01:06:49.616] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:49.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:125:0) after 1m0s
[01:07:49.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:125:0)
[01:07:49.669] Timer tick, asking Buildbucket for the build status
[01:07:49.787] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:49.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:126:0) after 1m0s
[01:08:50.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:126:0)
[01:08:50.007] Timer tick, asking Buildbucket for the build status
[01:08:50.576] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:50.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:127:0) after 1m0s
[01:09:54.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:127:0)
[01:09:54.319] Timer tick, asking Buildbucket for the build status
[01:10:01.490] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:01.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:128:0) after 1m0s
[01:11:01.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:128:0)
[01:11:01.585] Timer tick, asking Buildbucket for the build status
[01:11:01.865] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:01.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:129:0) after 1m0s
[01:12:01.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:129:0)
[01:12:01.954] Timer tick, asking Buildbucket for the build status
[01:12:02.106] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:02.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:130:0) after 1m0s
[01:13:02.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:130:0)
[01:13:02.825] Timer tick, asking Buildbucket for the build status
[01:13:03.249] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:03.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:131:0) after 1m0s
[01:14:05.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:131:0)
[01:14:05.318] Timer tick, asking Buildbucket for the build status
[01:14:05.456] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:05.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:132:0) after 1m0s
[01:15:09.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:132:0)
[01:15:09.814] Timer tick, asking Buildbucket for the build status
[01:15:10.404] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:10.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:133:0) after 1m0s
[01:16:12.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:133:0)
[01:16:12.288] Timer tick, asking Buildbucket for the build status
[01:16:12.743] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:12.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:134:0) after 1m0s
[01:17:14.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:134:0)
[01:17:14.977] Timer tick, asking Buildbucket for the build status
[01:17:18.278] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:18.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:135:0) after 1m0s
[01:18:21.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:135:0)
[01:18:21.499] Timer tick, asking Buildbucket for the build status
[01:18:21.641] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:21.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:136:0) after 1m0s
[01:19:21.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:136:0)
[01:19:21.950] Timer tick, asking Buildbucket for the build status
[01:19:22.516] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:22.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:137:0) after 1m0s
[01:20:22.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:137:0)
[01:20:22.603] Timer tick, asking Buildbucket for the build status
[01:20:22.807] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:22.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:138:0) after 1m0s
[01:21:22.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:138:0)
[01:21:22.896] Timer tick, asking Buildbucket for the build status
[01:21:23.255] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:23.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:139:0) after 1m0s
[01:22:23.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:139:0)
[01:22:23.347] Timer tick, asking Buildbucket for the build status
[01:22:23.507] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:23.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:140:0) after 1m0s
[01:23:25.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:140:0)
[01:23:25.618] Timer tick, asking Buildbucket for the build status
[01:23:25.778] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:25.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:141:0) after 1m0s
[01:24:25.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:141:0)
[01:24:25.877] Timer tick, asking Buildbucket for the build status
[01:24:26.711] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:26.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:142:0) after 1m0s
[01:25:28.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:142:0)
[01:25:28.333] Timer tick, asking Buildbucket for the build status
[01:25:28.490] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:28.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:143:0) after 1m0s
[01:26:30.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:143:0)
[01:26:30.639] Timer tick, asking Buildbucket for the build status
[01:26:30.872] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:30.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:144:0) after 1m0s
[01:27:34.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:144:0)
[01:27:34.047] Timer tick, asking Buildbucket for the build status
[01:27:34.740] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:34.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:145:0) after 1m0s
[01:28:35.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:145:0)
[01:28:35.257] Timer tick, asking Buildbucket for the build status
[01:28:35.417] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:35.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:146:0) after 1m0s
[01:29:35.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:146:0)
[01:29:35.535] Timer tick, asking Buildbucket for the build status
[01:29:38.691] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:38.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:147:0) after 1m0s
[01:30:38.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:147:0)
[01:30:38.718] Timer tick, asking Buildbucket for the build status
[01:30:39.098] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:39.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:148:0) after 1m0s
[01:31:39.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:148:0)
[01:31:39.139] Timer tick, asking Buildbucket for the build status
[01:31:39.295] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:39.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:149:0) after 1m0s
[01:32:39.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:149:0)
[01:32:39.293] Timer tick, asking Buildbucket for the build status
[01:32:39.485] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:39.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:150:0) after 1m0s
[01:33:39.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:150:0)
[01:33:39.522] Timer tick, asking Buildbucket for the build status
[01:33:39.659] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:39.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:151:0) after 1m0s
[01:34:39.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:151:0)
[01:34:39.721] Timer tick, asking Buildbucket for the build status
[01:34:39.872] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:39.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:152:0) after 1m0s
[01:35:39.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:152:0)
[01:35:39.966] Timer tick, asking Buildbucket for the build status
[01:35:43.538] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:43.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:153:0) after 1m0s
[01:36:43.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:153:0)
[01:36:43.642] Timer tick, asking Buildbucket for the build status
[01:36:43.806] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:43.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:154:0) after 1m0s
[01:37:43.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:154:0)
[01:37:43.826] Timer tick, asking Buildbucket for the build status
[01:37:44.122] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:44.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:155:0) after 1m0s
[01:38:44.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:155:0)
[01:38:44.269] Timer tick, asking Buildbucket for the build status
[01:38:44.675] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:44.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:156:0) after 1m0s
[01:39:44.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:156:0)
[01:39:44.718] Timer tick, asking Buildbucket for the build status
[01:39:46.462] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:46.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:157:0) after 1m0s
[01:40:46.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:157:0)
[01:40:46.500] Timer tick, asking Buildbucket for the build status
[01:40:46.698] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:46.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:158:0) after 1m0s
[01:41:46.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:158:0)
[01:41:46.754] Timer tick, asking Buildbucket for the build status
[01:41:46.885] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:46.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:159:0) after 1m0s
[01:42:46.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:159:0)
[01:42:46.923] Timer tick, asking Buildbucket for the build status
[01:42:47.050] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:47.050] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:160:0) after 1m0s
[01:43:47.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:160:0)
[01:43:47.101] Timer tick, asking Buildbucket for the build status
[01:43:47.247] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:47.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:161:0) after 1m0s
[01:44:47.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:161:0)
[01:44:47.296] Timer tick, asking Buildbucket for the build status
[01:44:47.532] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:47.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:162:0) after 1m0s
[01:45:47.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:162:0)
[01:45:47.576] Timer tick, asking Buildbucket for the build status
[01:45:49.296] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:49.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:163:0) after 1m0s
[01:46:49.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:163:0)
[01:46:49.320] Timer tick, asking Buildbucket for the build status
[01:46:49.467] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:49.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:164:0) after 1m0s
[01:47:49.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:164:0)
[01:47:49.497] Timer tick, asking Buildbucket for the build status
[01:47:49.612] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:49.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:165:0) after 1m0s
[01:48:49.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:165:0)
[01:48:49.651] Timer tick, asking Buildbucket for the build status
[01:48:49.781] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:49.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:166:0) after 1m0s
[01:49:49.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:166:0)
[01:49:49.796] Timer tick, asking Buildbucket for the build status
[01:49:49.995] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:49.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:167:0) after 1m0s
[01:50:50.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:167:0)
[01:50:50.013] Timer tick, asking Buildbucket for the build status
[01:50:50.164] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:50.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:168:0) after 1m0s
[01:51:50.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:168:0)
[01:51:50.197] Timer tick, asking Buildbucket for the build status
[01:51:50.363] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:50.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:169:0) after 1m0s
[01:52:50.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:169:0)
[01:52:50.448] Timer tick, asking Buildbucket for the build status
[01:52:50.876] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:50.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:170:0) after 1m0s
[01:53:50.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:170:0)
[01:53:50.918] Timer tick, asking Buildbucket for the build status
[01:53:51.139] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:51.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:171:0) after 1m0s
[01:54:51.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:171:0)
[01:54:51.196] Timer tick, asking Buildbucket for the build status
[01:55:00.929] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:00.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:172:0) after 1m0s
[01:56:02.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:172:0)
[01:56:02.198] Timer tick, asking Buildbucket for the build status
[01:56:02.352] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:02.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:173:0) after 1m0s
[01:57:02.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:173:0)
[01:57:02.378] Timer tick, asking Buildbucket for the build status
[01:57:02.486] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:02.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:174:0) after 1m0s
[01:58:02.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:174:0)
[01:58:02.558] Timer tick, asking Buildbucket for the build status
[01:58:02.888] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:02.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:175:0) after 1m0s
[01:59:03.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:175:0)
[01:59:03.001] Timer tick, asking Buildbucket for the build status
[01:59:03.459] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:03.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:176:0) after 1m0s
[02:00:03.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:176:0)
[02:00:03.475] Timer tick, asking Buildbucket for the build status
[02:00:04.043] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:04.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:177:0) after 1m0s
[02:01:04.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:177:0)
[02:01:04.084] Timer tick, asking Buildbucket for the build status
[02:01:04.256] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:04.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:178:0) after 1m0s
[02:02:04.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:178:0)
[02:02:04.286] Timer tick, asking Buildbucket for the build status
[02:02:04.471] Build 8876389370470767600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:04.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9041819438047857520:179:0) after 1m0s
[02:02:59.655] Received PubSub notification, asking Buildbucket for the build status
[02:02:59.707] Build 8876389370470767600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:02:59.707] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1593223378146794",
    "created_by": "project:infra",
    "created_ts": "1593212457168210",
    "id": "8876389370470767600",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4183.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"515c8850-754f-4e92-8b09-341ffd889e54\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4183.3\"}}",
    "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-hji1\"], \"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": "1593212474302253",
    "status": "COMPLETED",
    "status_changed_ts": "1593223379108115",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9041819438047857520",
      "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/8876389370470767600/+/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:4d0bae5c7d807110",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1593223379163690",
    "url": "https://ci.chromium.org/b/8876389370470767600",
    "utcnow_ts": "1593223379700965"
  }
}
[02:02:59.707] Invocation finished in 3h2m9.149340633s with status SUCCEEDED