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

• parent_buildername:publish_tarball
• user_agent:recipe

[08:15:42.589] New invocation is queued and will start shortly
[08:15:42.589] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:15:43.812] Starting the invocation (attempt 1)
[08:15:43.861] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:15:43.861] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:15:43.861] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9051478404249685168",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"82.0.4084.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"e2af2e81-991e-4a8b-8b08-82b099189d70\",\"title\":\"publish_tarball/0\"}]},\"version\":\"82.0.4084.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:9051478404249685168",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:15:44.935] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1584000944051117",
    "id": "8886048342049263456",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4084.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e2af2e81-991e-4a8b-8b08-82b099189d70\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"82.0.4084.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1584000944639377",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9051478404249685168",
      "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/8886048342049263456/+/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": "1584000944639601",
    "url": "https://ci.chromium.org/b/8886048342049263456",
    "utcnow_ts": "1584000944925717"
  }
}
[08:15:44.935] Task URL: https://ci.chromium.org/b/8886048342049263456
[08:15:44.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:2:0) after 1m0s
[08:16:02.634] Received PubSub notification, asking Buildbucket for the build status
[08:16:02.799] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:44.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:2:0)
[08:16:44.964] Timer tick, asking Buildbucket for the build status
[08:16:45.151] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:45.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:4:0) after 1m0s
[08:17:45.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:4:0)
[08:17:45.220] Timer tick, asking Buildbucket for the build status
[08:17:45.670] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:45.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:5:0) after 1m0s
[08:18:45.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:5:0)
[08:18:45.699] Timer tick, asking Buildbucket for the build status
[08:18:45.947] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:45.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:6:0) after 1m0s
[08:19:46.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:6:0)
[08:19:46.002] Timer tick, asking Buildbucket for the build status
[08:19:46.228] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:46.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:7:0) after 1m0s
[08:20:46.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:7:0)
[08:20:46.262] Timer tick, asking Buildbucket for the build status
[08:20:46.421] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:46.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:8:0) after 1m0s
[08:21:46.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:8:0)
[08:21:46.450] Timer tick, asking Buildbucket for the build status
[08:21:46.558] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:46.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:9:0) after 1m0s
[08:22:46.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:9:0)
[08:22:46.662] Timer tick, asking Buildbucket for the build status
[08:22:46.806] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:46.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:10:0) after 1m0s
[08:23:46.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:10:0)
[08:23:46.921] Timer tick, asking Buildbucket for the build status
[08:23:47.067] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:47.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:11:0) after 1m0s
[08:24:47.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:11:0)
[08:24:47.168] Timer tick, asking Buildbucket for the build status
[08:24:47.388] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:47.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:12:0) after 1m0s
[08:25:47.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:12:0)
[08:25:47.407] Timer tick, asking Buildbucket for the build status
[08:25:47.505] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:47.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:13:0) after 1m0s
[08:26:47.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:13:0)
[08:26:47.559] Timer tick, asking Buildbucket for the build status
[08:26:47.663] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:47.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:14:0) after 1m0s
[08:27:47.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:14:0)
[08:27:47.655] Timer tick, asking Buildbucket for the build status
[08:27:48.034] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:48.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:15:0) after 1m0s
[08:28:48.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:15:0)
[08:28:48.165] Timer tick, asking Buildbucket for the build status
[08:28:48.285] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:48.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:16:0) after 1m0s
[08:29:48.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:16:0)
[08:29:48.304] Timer tick, asking Buildbucket for the build status
[08:29:48.566] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:48.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:17:0) after 1m0s
[08:30:48.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:17:0)
[08:30:48.617] Timer tick, asking Buildbucket for the build status
[08:30:48.762] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:48.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:18:0) after 1m0s
[08:31:48.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:18:0)
[08:31:48.803] Timer tick, asking Buildbucket for the build status
[08:31:48.991] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:48.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:19:0) after 1m0s
[08:32:49.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:19:0)
[08:32:49.003] Timer tick, asking Buildbucket for the build status
[08:32:49.147] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:49.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:20:0) after 1m0s
[08:33:49.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:20:0)
[08:33:49.184] Timer tick, asking Buildbucket for the build status
[08:33:49.365] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:49.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:21:0) after 1m0s
[08:34:49.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:21:0)
[08:34:49.407] Timer tick, asking Buildbucket for the build status
[08:34:49.540] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:49.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:22:0) after 1m0s
[08:35:49.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:22:0)
[08:35:49.647] Timer tick, asking Buildbucket for the build status
[08:35:49.802] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:49.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:23:0) after 1m0s
[08:36:49.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:23:0)
[08:36:49.870] Timer tick, asking Buildbucket for the build status
[08:36:49.999] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:49.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:24:0) after 1m0s
[08:37:50.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:24:0)
[08:37:50.082] Timer tick, asking Buildbucket for the build status
[08:37:50.187] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:50.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:25:0) after 1m0s
[08:38:50.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:25:0)
[08:38:50.291] Timer tick, asking Buildbucket for the build status
[08:38:50.481] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:50.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:26:0) after 1m0s
[08:39:50.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:26:0)
[08:39:50.511] Timer tick, asking Buildbucket for the build status
[08:39:50.622] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:50.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:27:0) after 1m0s
[08:40:50.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:27:0)
[08:40:50.713] Timer tick, asking Buildbucket for the build status
[08:40:51.036] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:51.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:28:0) after 1m0s
[08:41:51.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:28:0)
[08:41:51.137] Timer tick, asking Buildbucket for the build status
[08:41:51.440] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:51.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:29:0) after 1m0s
[08:42:51.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:29:0)
[08:42:51.479] Timer tick, asking Buildbucket for the build status
[08:42:51.633] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:51.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:30:0) after 1m0s
[08:43:51.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:30:0)
[08:43:51.670] Timer tick, asking Buildbucket for the build status
[08:43:51.789] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:51.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:31:0) after 1m0s
[08:44:51.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:31:0)
[08:44:51.927] Timer tick, asking Buildbucket for the build status
[08:44:52.263] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:52.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:32:0) after 1m0s
[08:45:52.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:32:0)
[08:45:52.358] Timer tick, asking Buildbucket for the build status
[08:45:52.522] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:52.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:33:0) after 1m0s
[08:46:52.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:33:0)
[08:46:52.561] Timer tick, asking Buildbucket for the build status
[08:46:52.677] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:52.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:34:0) after 1m0s
[08:47:52.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:34:0)
[08:47:52.677] Timer tick, asking Buildbucket for the build status
[08:47:52.787] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:52.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:35:0) after 1m0s
[08:48:52.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:35:0)
[08:48:52.833] Timer tick, asking Buildbucket for the build status
[08:48:52.965] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:52.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:36:0) after 1m0s
[08:49:53.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:36:0)
[08:49:53.106] Timer tick, asking Buildbucket for the build status
[08:49:53.211] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:53.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:37:0) after 1m0s
[08:50:53.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:37:0)
[08:50:53.263] Timer tick, asking Buildbucket for the build status
[08:50:53.383] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:53.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:38:0) after 1m0s
[08:51:53.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:38:0)
[08:51:53.493] Timer tick, asking Buildbucket for the build status
[08:51:53.765] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:53.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:39:0) after 1m0s
[08:52:53.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:39:0)
[08:52:53.846] Timer tick, asking Buildbucket for the build status
[08:52:54.188] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:54.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:40:0) after 1m0s
[08:53:54.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:40:0)
[08:53:54.760] Timer tick, asking Buildbucket for the build status
[08:53:54.856] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:54.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:41:0) after 1m0s
[08:54:55.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:41:0)
[08:54:55.169] Timer tick, asking Buildbucket for the build status
[08:54:55.577] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:55.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:42:0) after 1m0s
[08:55:55.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:42:0)
[08:55:55.694] Timer tick, asking Buildbucket for the build status
[08:55:55.819] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:55.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:43:0) after 1m0s
[08:56:55.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:43:0)
[08:56:55.917] Timer tick, asking Buildbucket for the build status
[08:56:56.054] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:56.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:44:0) after 1m0s
[08:57:56.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:44:0)
[08:57:56.157] Timer tick, asking Buildbucket for the build status
[08:57:56.270] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:56.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:45:0) after 1m0s
[08:58:56.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:45:0)
[08:58:56.267] Timer tick, asking Buildbucket for the build status
[08:58:56.374] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:56.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:46:0) after 1m0s
[08:59:56.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:46:0)
[08:59:56.497] Timer tick, asking Buildbucket for the build status
[08:59:56.740] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:56.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:47:0) after 1m0s
[09:00:56.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:47:0)
[09:00:56.840] Timer tick, asking Buildbucket for the build status
[09:00:56.953] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:56.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:48:0) after 1m0s
[09:01:57.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:48:0)
[09:01:57.013] Timer tick, asking Buildbucket for the build status
[09:01:57.344] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:57.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:49:0) after 1m0s
[09:02:57.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:49:0)
[09:02:57.421] Timer tick, asking Buildbucket for the build status
[09:02:57.548] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:57.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:50:0) after 1m0s
[09:03:57.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:50:0)
[09:03:57.651] Timer tick, asking Buildbucket for the build status
[09:03:57.757] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:57.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:51:0) after 1m0s
[09:04:57.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:51:0)
[09:04:57.927] Timer tick, asking Buildbucket for the build status
[09:04:58.098] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:58.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:52:0) after 1m0s
[09:05:58.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:52:0)
[09:05:58.168] Timer tick, asking Buildbucket for the build status
[09:05:58.576] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:58.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:53:0) after 1m0s
[09:06:58.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:53:0)
[09:06:58.572] Timer tick, asking Buildbucket for the build status
[09:06:58.727] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:58.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:54:0) after 1m0s
[09:07:58.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:54:0)
[09:07:58.754] Timer tick, asking Buildbucket for the build status
[09:07:58.977] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:58.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:55:0) after 1m0s
[09:08:58.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:55:0)
[09:08:58.999] Timer tick, asking Buildbucket for the build status
[09:08:59.166] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:59.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:56:0) after 1m0s
[09:09:59.260] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:56:0)
[09:09:59.260] Timer tick, asking Buildbucket for the build status
[09:09:59.478] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:59.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:57:0) after 1m0s
[09:10:59.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:57:0)
[09:10:59.495] Timer tick, asking Buildbucket for the build status
[09:10:59.604] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:59.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:58:0) after 1m0s
[09:11:59.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:58:0)
[09:11:59.627] Timer tick, asking Buildbucket for the build status
[09:12:00.001] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:00.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:59:0) after 1m0s
[09:13:00.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:59:0)
[09:13:00.066] Timer tick, asking Buildbucket for the build status
[09:13:00.450] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:00.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:60:0) after 1m0s
[09:14:00.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:60:0)
[09:14:00.508] Timer tick, asking Buildbucket for the build status
[09:14:00.684] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:00.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:61:0) after 1m0s
[09:15:00.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:61:0)
[09:15:00.860] Timer tick, asking Buildbucket for the build status
[09:15:01.011] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:01.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:62:0) after 1m0s
[09:16:01.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:62:0)
[09:16:01.124] Timer tick, asking Buildbucket for the build status
[09:16:01.535] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:01.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:63:0) after 1m0s
[09:17:01.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:63:0)
[09:17:01.597] Timer tick, asking Buildbucket for the build status
[09:17:01.976] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:01.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:64:0) after 1m0s
[09:18:02.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:64:0)
[09:18:02.052] Timer tick, asking Buildbucket for the build status
[09:18:02.300] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:02.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:65:0) after 1m0s
[09:19:02.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:65:0)
[09:19:02.328] Timer tick, asking Buildbucket for the build status
[09:19:02.525] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:02.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:66:0) after 1m0s
[09:20:02.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:66:0)
[09:20:02.586] Timer tick, asking Buildbucket for the build status
[09:20:02.848] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:02.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:67:0) after 1m0s
[09:21:02.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:67:0)
[09:21:02.904] Timer tick, asking Buildbucket for the build status
[09:21:03.174] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:03.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:68:0) after 1m0s
[09:22:03.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:68:0)
[09:22:03.223] Timer tick, asking Buildbucket for the build status
[09:22:03.546] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:03.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:69:0) after 1m0s
[09:23:03.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:69:0)
[09:23:03.601] Timer tick, asking Buildbucket for the build status
[09:23:03.801] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:03.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:70:0) after 1m0s
[09:24:03.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:70:0)
[09:24:03.815] Timer tick, asking Buildbucket for the build status
[09:24:03.925] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:03.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:71:0) after 1m0s
[09:25:03.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:71:0)
[09:25:03.961] Timer tick, asking Buildbucket for the build status
[09:25:04.064] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:04.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:72:0) after 1m0s
[09:26:04.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:72:0)
[09:26:04.164] Timer tick, asking Buildbucket for the build status
[09:26:04.297] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:04.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:73:0) after 1m0s
[09:27:04.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:73:0)
[09:27:04.323] Timer tick, asking Buildbucket for the build status
[09:27:04.456] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:04.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:74:0) after 1m0s
[09:28:04.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:74:0)
[09:28:04.505] Timer tick, asking Buildbucket for the build status
[09:28:04.660] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:04.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:75:0) after 1m0s
[09:29:04.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:75:0)
[09:29:04.719] Timer tick, asking Buildbucket for the build status
[09:29:05.038] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:05.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:76:0) after 1m0s
[09:30:05.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:76:0)
[09:30:05.076] Timer tick, asking Buildbucket for the build status
[09:30:05.220] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:05.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:77:0) after 1m0s
[09:31:05.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:77:0)
[09:31:05.373] Timer tick, asking Buildbucket for the build status
[09:31:05.512] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:05.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:78:0) after 1m0s
[09:32:05.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:78:0)
[09:32:05.569] Timer tick, asking Buildbucket for the build status
[09:32:05.831] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:05.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:79:0) after 1m0s
[09:33:05.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:79:0)
[09:33:05.847] Timer tick, asking Buildbucket for the build status
[09:33:05.975] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:05.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:80:0) after 1m0s
[09:34:06.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:80:0)
[09:34:06.015] Timer tick, asking Buildbucket for the build status
[09:34:06.189] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:06.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:81:0) after 1m0s
[09:35:06.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:81:0)
[09:35:06.223] Timer tick, asking Buildbucket for the build status
[09:35:06.481] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:06.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:82:0) after 1m0s
[09:36:06.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:82:0)
[09:36:06.682] Timer tick, asking Buildbucket for the build status
[09:36:06.984] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:06.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:83:0) after 1m0s
[09:37:07.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:83:0)
[09:37:07.060] Timer tick, asking Buildbucket for the build status
[09:37:07.202] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:07.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:84:0) after 1m0s
[09:38:07.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:84:0)
[09:38:07.250] Timer tick, asking Buildbucket for the build status
[09:38:07.371] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:07.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:85:0) after 1m0s
[09:39:07.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:85:0)
[09:39:07.444] Timer tick, asking Buildbucket for the build status
[09:39:07.619] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:07.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:86:0) after 1m0s
[09:40:07.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:86:0)
[09:40:07.620] Timer tick, asking Buildbucket for the build status
[09:40:07.741] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:07.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:87:0) after 1m0s
[09:41:07.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:87:0)
[09:41:07.747] Timer tick, asking Buildbucket for the build status
[09:41:07.878] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:07.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:88:0) after 1m0s
[09:42:07.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:88:0)
[09:42:07.957] Timer tick, asking Buildbucket for the build status
[09:42:08.067] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:08.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:89:0) after 1m0s
[09:43:08.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:89:0)
[09:43:08.130] Timer tick, asking Buildbucket for the build status
[09:43:08.268] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:08.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:90:0) after 1m0s
[09:44:08.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:90:0)
[09:44:08.307] Timer tick, asking Buildbucket for the build status
[09:44:08.427] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:08.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:91:0) after 1m0s
[09:45:08.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:91:0)
[09:45:08.532] Timer tick, asking Buildbucket for the build status
[09:45:08.668] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:08.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:92:0) after 1m0s
[09:46:08.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:92:0)
[09:46:08.723] Timer tick, asking Buildbucket for the build status
[09:46:09.063] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:09.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:93:0) after 1m0s
[09:47:09.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:93:0)
[09:47:09.129] Timer tick, asking Buildbucket for the build status
[09:47:09.219] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:09.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:94:0) after 1m0s
[09:48:09.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:94:0)
[09:48:09.251] Timer tick, asking Buildbucket for the build status
[09:48:09.386] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:09.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:95:0) after 1m0s
[09:49:09.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:95:0)
[09:49:09.403] Timer tick, asking Buildbucket for the build status
[09:49:09.512] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:09.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:96:0) after 1m0s
[09:50:09.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:96:0)
[09:50:09.543] Timer tick, asking Buildbucket for the build status
[09:50:09.652] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:09.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:97:0) after 1m0s
[09:51:09.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:97:0)
[09:51:09.712] Timer tick, asking Buildbucket for the build status
[09:51:10.108] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:10.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:98:0) after 1m0s
[09:52:10.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:98:0)
[09:52:10.161] Timer tick, asking Buildbucket for the build status
[09:52:10.283] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:10.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:99:0) after 1m0s
[09:53:10.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:99:0)
[09:53:10.355] Timer tick, asking Buildbucket for the build status
[09:53:10.551] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:10.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:100:0) after 1m0s
[09:54:10.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:100:0)
[09:54:10.681] Timer tick, asking Buildbucket for the build status
[09:54:11.269] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:11.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:101:0) after 1m0s
[09:55:11.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:101:0)
[09:55:11.437] Timer tick, asking Buildbucket for the build status
[09:55:11.547] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:11.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:102:0) after 1m0s
[09:56:11.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:102:0)
[09:56:11.648] Timer tick, asking Buildbucket for the build status
[09:56:11.779] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:11.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:103:0) after 1m0s
[09:57:11.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:103:0)
[09:57:11.923] Timer tick, asking Buildbucket for the build status
[09:57:12.152] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:12.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:104:0) after 1m0s
[09:58:12.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:104:0)
[09:58:12.194] Timer tick, asking Buildbucket for the build status
[09:58:12.299] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:12.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:105:0) after 1m0s
[09:59:12.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:105:0)
[09:59:12.580] Timer tick, asking Buildbucket for the build status
[09:59:12.733] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:12.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:106:0) after 1m0s
[10:00:12.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:106:0)
[10:00:12.818] Timer tick, asking Buildbucket for the build status
[10:00:13.063] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:13.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:107:0) after 1m0s
[10:01:13.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:107:0)
[10:01:13.162] Timer tick, asking Buildbucket for the build status
[10:01:13.270] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:13.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:108:0) after 1m0s
[10:02:13.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:108:0)
[10:02:13.372] Timer tick, asking Buildbucket for the build status
[10:02:13.761] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:13.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:109:0) after 1m0s
[10:03:13.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:109:0)
[10:03:13.819] Timer tick, asking Buildbucket for the build status
[10:03:13.957] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:13.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:110:0) after 1m0s
[10:04:14.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:110:0)
[10:04:14.044] Timer tick, asking Buildbucket for the build status
[10:04:14.211] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:14.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:111:0) after 1m0s
[10:05:14.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:111:0)
[10:05:14.243] Timer tick, asking Buildbucket for the build status
[10:05:14.392] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:14.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:112:0) after 1m0s
[10:06:14.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:112:0)
[10:06:14.401] Timer tick, asking Buildbucket for the build status
[10:06:14.699] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:14.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:113:0) after 1m0s
[10:07:14.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:113:0)
[10:07:14.783] Timer tick, asking Buildbucket for the build status
[10:07:14.915] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:14.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:114:0) after 1m0s
[10:08:14.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:114:0)
[10:08:14.983] Timer tick, asking Buildbucket for the build status
[10:08:15.119] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:15.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:115:0) after 1m0s
[10:09:15.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:115:0)
[10:09:15.223] Timer tick, asking Buildbucket for the build status
[10:09:15.487] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:15.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:116:0) after 1m0s
[10:10:15.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:116:0)
[10:10:15.549] Timer tick, asking Buildbucket for the build status
[10:10:15.715] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:15.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:117:0) after 1m0s
[10:11:15.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:117:0)
[10:11:15.746] Timer tick, asking Buildbucket for the build status
[10:11:15.942] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:15.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:118:0) after 1m0s
[10:12:16.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:118:0)
[10:12:16.017] Timer tick, asking Buildbucket for the build status
[10:12:16.210] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:16.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:119:0) after 1m0s
[10:13:16.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:119:0)
[10:13:16.277] Timer tick, asking Buildbucket for the build status
[10:13:16.505] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:16.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:120:0) after 1m0s
[10:14:16.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:120:0)
[10:14:16.551] Timer tick, asking Buildbucket for the build status
[10:14:16.720] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:16.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:121:0) after 1m0s
[10:15:16.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:121:0)
[10:15:16.780] Timer tick, asking Buildbucket for the build status
[10:15:17.160] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:17.160] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:122:0) after 1m0s
[10:16:17.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:122:0)
[10:16:17.191] Timer tick, asking Buildbucket for the build status
[10:16:17.677] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:17.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:123:0) after 1m0s
[10:17:17.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:123:0)
[10:17:17.761] Timer tick, asking Buildbucket for the build status
[10:17:17.905] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:17.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:124:0) after 1m0s
[10:18:18.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:124:0)
[10:18:18.010] Timer tick, asking Buildbucket for the build status
[10:18:18.130] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:18.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:125:0) after 1m0s
[10:19:18.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:125:0)
[10:19:18.219] Timer tick, asking Buildbucket for the build status
[10:19:18.575] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:18.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:126:0) after 1m0s
[10:20:18.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:126:0)
[10:20:18.789] Timer tick, asking Buildbucket for the build status
[10:20:18.909] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:18.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:127:0) after 1m0s
[10:21:19.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:127:0)
[10:21:19.131] Timer tick, asking Buildbucket for the build status
[10:21:19.264] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:19.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:128:0) after 1m0s
[10:22:19.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:128:0)
[10:22:19.415] Timer tick, asking Buildbucket for the build status
[10:22:19.727] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:19.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:129:0) after 1m0s
[10:23:19.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:129:0)
[10:23:19.767] Timer tick, asking Buildbucket for the build status
[10:23:20.081] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:20.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:130:0) after 1m0s
[10:24:20.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:130:0)
[10:24:20.338] Timer tick, asking Buildbucket for the build status
[10:24:20.672] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:20.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:131:0) after 1m0s
[10:25:20.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:131:0)
[10:25:20.748] Timer tick, asking Buildbucket for the build status
[10:25:20.832] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:20.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:132:0) after 1m0s
[10:26:20.866] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:132:0)
[10:26:20.866] Timer tick, asking Buildbucket for the build status
[10:26:21.003] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:21.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:133:0) after 1m0s
[10:27:22.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:133:0)
[10:27:22.637] Timer tick, asking Buildbucket for the build status
[10:27:22.884] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:22.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:134:0) after 1m0s
[10:28:22.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:134:0)
[10:28:22.963] Timer tick, asking Buildbucket for the build status
[10:28:23.105] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:23.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:135:0) after 1m0s
[10:29:23.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:135:0)
[10:29:23.212] Timer tick, asking Buildbucket for the build status
[10:29:23.572] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:23.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:136:0) after 1m0s
[10:30:23.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:136:0)
[10:30:23.637] Timer tick, asking Buildbucket for the build status
[10:30:23.769] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:23.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:137:0) after 1m0s
[10:31:23.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:137:0)
[10:31:23.875] Timer tick, asking Buildbucket for the build status
[10:31:24.093] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:24.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:138:0) after 1m0s
[10:32:24.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:138:0)
[10:32:24.232] Timer tick, asking Buildbucket for the build status
[10:32:24.385] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:24.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:139:0) after 1m0s
[10:33:24.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:139:0)
[10:33:24.414] Timer tick, asking Buildbucket for the build status
[10:33:24.720] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:24.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:140:0) after 1m0s
[10:34:24.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:140:0)
[10:34:24.989] Timer tick, asking Buildbucket for the build status
[10:34:25.588] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:25.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:141:0) after 1m0s
[10:35:25.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:141:0)
[10:35:25.676] Timer tick, asking Buildbucket for the build status
[10:35:25.806] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:25.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:142:0) after 1m0s
[10:36:25.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:142:0)
[10:36:25.991] Timer tick, asking Buildbucket for the build status
[10:36:26.432] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:26.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:143:0) after 1m0s
[10:37:26.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:143:0)
[10:37:26.469] Timer tick, asking Buildbucket for the build status
[10:37:26.581] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:26.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:144:0) after 1m0s
[10:38:26.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:144:0)
[10:38:26.694] Timer tick, asking Buildbucket for the build status
[10:38:26.841] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:26.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:145:0) after 1m0s
[10:39:27.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:145:0)
[10:39:27.316] Timer tick, asking Buildbucket for the build status
[10:39:27.495] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:27.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:146:0) after 1m0s
[10:40:27.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:146:0)
[10:40:27.641] Timer tick, asking Buildbucket for the build status
[10:40:27.752] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:27.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:147:0) after 1m0s
[10:41:27.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:147:0)
[10:41:27.855] Timer tick, asking Buildbucket for the build status
[10:41:28.099] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:28.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:148:0) after 1m0s
[10:42:28.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:148:0)
[10:42:28.135] Timer tick, asking Buildbucket for the build status
[10:42:28.253] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:28.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:149:0) after 1m0s
[10:43:28.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:149:0)
[10:43:28.422] Timer tick, asking Buildbucket for the build status
[10:43:28.804] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:28.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:150:0) after 1m0s
[10:44:28.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:150:0)
[10:44:28.828] Timer tick, asking Buildbucket for the build status
[10:44:29.111] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:29.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:151:0) after 1m0s
[10:45:29.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:151:0)
[10:45:29.322] Timer tick, asking Buildbucket for the build status
[10:45:29.440] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:29.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:152:0) after 1m0s
[10:46:29.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:152:0)
[10:46:29.493] Timer tick, asking Buildbucket for the build status
[10:46:29.613] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:29.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:153:0) after 1m0s
[10:47:29.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:153:0)
[10:47:29.901] Timer tick, asking Buildbucket for the build status
[10:47:30.041] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:30.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:154:0) after 1m0s
[10:48:30.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:154:0)
[10:48:30.095] Timer tick, asking Buildbucket for the build status
[10:48:30.200] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:30.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:155:0) after 1m0s
[10:49:30.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:155:0)
[10:49:30.319] Timer tick, asking Buildbucket for the build status
[10:49:30.656] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:30.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:156:0) after 1m0s
[10:50:30.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:156:0)
[10:50:30.722] Timer tick, asking Buildbucket for the build status
[10:50:30.837] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:30.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:157:0) after 1m0s
[10:51:30.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:157:0)
[10:51:30.921] Timer tick, asking Buildbucket for the build status
[10:51:31.040] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:31.040] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:158:0) after 1m0s
[10:52:31.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:158:0)
[10:52:31.118] Timer tick, asking Buildbucket for the build status
[10:52:31.416] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:31.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:159:0) after 1m0s
[10:53:31.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:159:0)
[10:53:31.438] Timer tick, asking Buildbucket for the build status
[10:53:31.563] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:31.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:160:0) after 1m0s
[10:54:31.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:160:0)
[10:54:31.583] Timer tick, asking Buildbucket for the build status
[10:54:31.924] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:31.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:161:0) after 1m0s
[10:55:31.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:161:0)
[10:55:31.961] Timer tick, asking Buildbucket for the build status
[10:55:32.153] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:32.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:162:0) after 1m0s
[10:56:32.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:162:0)
[10:56:32.198] Timer tick, asking Buildbucket for the build status
[10:56:32.371] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:32.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:163:0) after 1m0s
[10:57:32.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:163:0)
[10:57:32.452] Timer tick, asking Buildbucket for the build status
[10:57:32.545] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:32.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:164:0) after 1m0s
[10:58:32.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:164:0)
[10:58:32.614] Timer tick, asking Buildbucket for the build status
[10:58:32.759] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:32.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:165:0) after 1m0s
[10:59:32.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:165:0)
[10:59:32.903] Timer tick, asking Buildbucket for the build status
[10:59:33.022] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:33.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:166:0) after 1m0s
[11:00:33.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:166:0)
[11:00:33.109] Timer tick, asking Buildbucket for the build status
[11:00:33.335] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:33.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:167:0) after 1m0s
[11:01:33.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:167:0)
[11:01:33.363] Timer tick, asking Buildbucket for the build status
[11:01:35.489] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:35.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:168:0) after 1m0s
[11:02:35.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:168:0)
[11:02:35.634] Timer tick, asking Buildbucket for the build status
[11:02:35.895] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:35.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:169:0) after 1m0s
[11:03:35.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:169:0)
[11:03:35.938] Timer tick, asking Buildbucket for the build status
[11:03:36.144] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:36.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:170:0) after 1m0s
[11:04:36.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:170:0)
[11:04:36.228] Timer tick, asking Buildbucket for the build status
[11:04:36.382] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:36.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:171:0) after 1m0s
[11:05:36.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:171:0)
[11:05:36.545] Timer tick, asking Buildbucket for the build status
[11:05:36.846] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:36.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:172:0) after 1m0s
[11:06:37.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:172:0)
[11:06:37.003] Timer tick, asking Buildbucket for the build status
[11:06:37.175] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:37.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:173:0) after 1m0s
[11:07:37.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:173:0)
[11:07:37.264] Timer tick, asking Buildbucket for the build status
[11:07:37.828] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:37.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:174:0) after 1m0s
[11:08:37.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:174:0)
[11:08:37.909] Timer tick, asking Buildbucket for the build status
[11:08:38.060] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:38.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:175:0) after 1m0s
[11:09:38.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:175:0)
[11:09:38.103] Timer tick, asking Buildbucket for the build status
[11:09:38.286] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:38.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:176:0) after 1m0s
[11:10:38.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:176:0)
[11:10:38.389] Timer tick, asking Buildbucket for the build status
[11:10:38.663] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:38.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:177:0) after 1m0s
[11:11:38.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:177:0)
[11:11:38.811] Timer tick, asking Buildbucket for the build status
[11:11:38.927] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:38.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:178:0) after 1m0s
[11:12:39.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:178:0)
[11:12:39.087] Timer tick, asking Buildbucket for the build status
[11:12:39.564] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:39.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:179:0) after 1m0s
[11:13:39.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:179:0)
[11:13:39.594] Timer tick, asking Buildbucket for the build status
[11:13:39.767] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:39.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:180:0) after 1m0s
[11:14:39.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:180:0)
[11:14:39.833] Timer tick, asking Buildbucket for the build status
[11:14:40.085] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:40.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:181:0) after 1m0s
[11:15:40.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:181:0)
[11:15:40.153] Timer tick, asking Buildbucket for the build status
[11:15:40.289] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:40.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:182:0) after 1m0s
[11:16:40.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:182:0)
[11:16:40.318] Timer tick, asking Buildbucket for the build status
[11:16:40.743] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:40.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:183:0) after 1m0s
[11:17:40.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:183:0)
[11:17:40.738] Timer tick, asking Buildbucket for the build status
[11:17:40.874] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:40.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:184:0) after 1m0s
[11:18:40.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:184:0)
[11:18:40.912] Timer tick, asking Buildbucket for the build status
[11:18:41.268] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:41.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:185:0) after 1m0s
[11:19:41.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:185:0)
[11:19:41.392] Timer tick, asking Buildbucket for the build status
[11:19:41.649] Build 8886048342049263456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:41.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9051478404249685168:186:0) after 1m0s
[11:20:13.498] Received PubSub notification, asking Buildbucket for the build status
[11:20:13.580] Build 8886048342049263456: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:20:13.580] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1584012009002373",
    "created_by": "project:infra",
    "created_ts": "1584000944051117",
    "id": "8886048342049263456",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4084.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e2af2e81-991e-4a8b-8b08-82b099189d70\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"82.0.4084.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"82.0.4084.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e2af2e81-991e-4a8b-8b08-82b099189d70\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-yo2k\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"82.0.4084.0\"}, \"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-yo2k\"], \"image\": [\"chrome-xenial-20030800-300841f894e\"], \"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\": [\"4874-3598771\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1584000961874992",
    "status": "COMPLETED",
    "status_changed_ts": "1584012009564985",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9051478404249685168",
      "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/8886048342049263456/+/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:4ae6a1d53fe80f10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1584012009585119",
    "url": "https://ci.chromium.org/b/8886048342049263456",
    "utcnow_ts": "1584012013569826"
  }
}
[11:20:13.580] Invocation finished in 3h4m31.010908126s with status SUCCEEDED