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

• parent_buildername:publish_tarball
• user_agent:recipe

[03:30:48.581] New invocation is queued and will start shortly
[03:30:48.581] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[03:30:49.688] Starting the invocation (attempt 1)
[03:30:49.732] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:30:49.732] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:30:49.732] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9042527228943093296",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4147.56\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"9ad13da5-17e5-4008-9e9a-963f0194f765\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4147.56\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9042527228943093296",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[03:30:50.707] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1592537449925700",
    "id": "8877097166865242976",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4147.56\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9ad13da5-17e5-4008-9e9a-963f0194f765\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4147.56\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1592537450396685",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9042527228943093296",
      "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/8877097166865242976/+/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": "1592537450396853",
    "url": "https://ci.chromium.org/b/8877097166865242976",
    "utcnow_ts": "1592537450697097"
  }
}
[03:30:50.707] Task URL: https://ci.chromium.org/b/8877097166865242976
[03:30:50.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:2:0) after 1m0s
[03:31:46.565] Received PubSub notification, asking Buildbucket for the build status
[03:31:46.700] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:50.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:2:0)
[03:31:50.789] Timer tick, asking Buildbucket for the build status
[03:31:50.852] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:50.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:4:0) after 1m0s
[03:32:50.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:4:0)
[03:32:50.972] Timer tick, asking Buildbucket for the build status
[03:32:51.105] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:51.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:5:0) after 1m0s
[03:33:51.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:5:0)
[03:33:51.163] Timer tick, asking Buildbucket for the build status
[03:33:51.708] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:51.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:6:0) after 1m0s
[03:34:51.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:6:0)
[03:34:51.784] Timer tick, asking Buildbucket for the build status
[03:34:51.916] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:51.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:7:0) after 1m0s
[03:35:51.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:7:0)
[03:35:51.991] Timer tick, asking Buildbucket for the build status
[03:35:52.316] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:52.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:8:0) after 1m0s
[03:36:52.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:8:0)
[03:36:52.582] Timer tick, asking Buildbucket for the build status
[03:36:52.807] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:52.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:9:0) after 1m0s
[03:37:52.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:9:0)
[03:37:52.883] Timer tick, asking Buildbucket for the build status
[03:37:53.171] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:53.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:10:0) after 1m0s
[03:38:53.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:10:0)
[03:38:53.230] Timer tick, asking Buildbucket for the build status
[03:38:56.035] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:56.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:11:0) after 1m0s
[03:39:56.054] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:11:0)
[03:39:56.054] Timer tick, asking Buildbucket for the build status
[03:39:56.237] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:56.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:12:0) after 1m0s
[03:40:56.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:12:0)
[03:40:56.257] Timer tick, asking Buildbucket for the build status
[03:40:56.442] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:56.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:13:0) after 1m0s
[03:41:56.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:13:0)
[03:41:56.474] Timer tick, asking Buildbucket for the build status
[03:41:56.610] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:56.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:14:0) after 1m0s
[03:42:56.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:14:0)
[03:42:56.638] Timer tick, asking Buildbucket for the build status
[03:42:56.794] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:56.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:15:0) after 1m0s
[03:43:56.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:15:0)
[03:43:56.836] Timer tick, asking Buildbucket for the build status
[03:43:57.457] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:57.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:16:0) after 1m0s
[03:44:57.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:16:0)
[03:44:57.499] Timer tick, asking Buildbucket for the build status
[03:44:58.218] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:58.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:17:0) after 1m0s
[03:45:58.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:17:0)
[03:45:58.237] Timer tick, asking Buildbucket for the build status
[03:45:58.697] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:58.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:18:0) after 1m0s
[03:46:58.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:18:0)
[03:46:58.718] Timer tick, asking Buildbucket for the build status
[03:46:59.901] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:59.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:19:0) after 1m0s
[03:47:59.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:19:0)
[03:47:59.934] Timer tick, asking Buildbucket for the build status
[03:48:00.767] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:00.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:20:0) after 1m0s
[03:49:01.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:20:0)
[03:49:01.124] Timer tick, asking Buildbucket for the build status
[03:49:01.728] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:01.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:21:0) after 1m0s
[03:50:01.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:21:0)
[03:50:01.748] Timer tick, asking Buildbucket for the build status
[03:50:01.963] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:01.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:22:0) after 1m0s
[03:51:02.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:22:0)
[03:51:02.011] Timer tick, asking Buildbucket for the build status
[03:51:02.210] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:02.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:23:0) after 1m0s
[03:52:02.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:23:0)
[03:52:02.323] Timer tick, asking Buildbucket for the build status
[03:52:02.477] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:02.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:24:0) after 1m0s
[03:53:02.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:24:0)
[03:53:02.554] Timer tick, asking Buildbucket for the build status
[03:53:02.696] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:02.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:25:0) after 1m0s
[03:54:02.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:25:0)
[03:54:02.714] Timer tick, asking Buildbucket for the build status
[03:54:05.410] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:05.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:26:0) after 1m0s
[03:55:05.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:26:0)
[03:55:05.511] Timer tick, asking Buildbucket for the build status
[03:55:05.801] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:05.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:27:0) after 1m0s
[03:56:06.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:27:0)
[03:56:06.113] Timer tick, asking Buildbucket for the build status
[03:56:06.346] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:06.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:28:0) after 1m0s
[03:57:06.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:28:0)
[03:57:06.353] Timer tick, asking Buildbucket for the build status
[03:57:06.833] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:06.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:29:0) after 1m0s
[03:58:06.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:29:0)
[03:58:06.902] Timer tick, asking Buildbucket for the build status
[03:58:07.064] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:07.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:30:0) after 1m0s
[03:59:07.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:30:0)
[03:59:07.144] Timer tick, asking Buildbucket for the build status
[03:59:09.059] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:09.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:31:0) after 1m0s
[04:00:09.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:31:0)
[04:00:09.159] Timer tick, asking Buildbucket for the build status
[04:00:09.323] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:09.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:32:0) after 1m0s
[04:01:09.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:32:0)
[04:01:09.551] Timer tick, asking Buildbucket for the build status
[04:01:11.804] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:11.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:33:0) after 1m0s
[04:02:11.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:33:0)
[04:02:11.932] Timer tick, asking Buildbucket for the build status
[04:02:12.072] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:12.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:34:0) after 1m0s
[04:03:12.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:34:0)
[04:03:12.115] Timer tick, asking Buildbucket for the build status
[04:03:12.319] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:12.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:35:0) after 1m0s
[04:04:12.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:35:0)
[04:04:12.357] Timer tick, asking Buildbucket for the build status
[04:04:12.506] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:12.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:36:0) after 1m0s
[04:05:12.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:36:0)
[04:05:12.536] Timer tick, asking Buildbucket for the build status
[04:05:12.703] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:12.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:37:0) after 1m0s
[04:06:12.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:37:0)
[04:06:12.752] Timer tick, asking Buildbucket for the build status
[04:06:12.963] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:12.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:38:0) after 1m0s
[04:07:12.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:38:0)
[04:07:12.991] Timer tick, asking Buildbucket for the build status
[04:07:13.743] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:13.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:39:0) after 1m0s
[04:08:13.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:39:0)
[04:08:13.784] Timer tick, asking Buildbucket for the build status
[04:08:13.924] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:13.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:40:0) after 1m0s
[04:09:13.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:40:0)
[04:09:13.982] Timer tick, asking Buildbucket for the build status
[04:09:14.139] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:14.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:41:0) after 1m0s
[04:10:14.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:41:0)
[04:10:14.237] Timer tick, asking Buildbucket for the build status
[04:10:14.452] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:14.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:42:0) after 1m0s
[04:11:14.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:42:0)
[04:11:14.572] Timer tick, asking Buildbucket for the build status
[04:11:14.829] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:14.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:43:0) after 1m0s
[04:12:14.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:43:0)
[04:12:14.931] Timer tick, asking Buildbucket for the build status
[04:12:15.257] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:15.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:44:0) after 1m0s
[04:13:15.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:44:0)
[04:13:15.314] Timer tick, asking Buildbucket for the build status
[04:13:15.472] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:15.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:45:0) after 1m0s
[04:14:15.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:45:0)
[04:14:15.567] Timer tick, asking Buildbucket for the build status
[04:14:15.716] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:15.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:46:0) after 1m0s
[04:15:15.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:46:0)
[04:15:15.822] Timer tick, asking Buildbucket for the build status
[04:15:16.165] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:16.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:47:0) after 1m0s
[04:16:16.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:47:0)
[04:16:16.306] Timer tick, asking Buildbucket for the build status
[04:16:16.428] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:16.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:48:0) after 1m0s
[04:17:16.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:48:0)
[04:17:16.771] Timer tick, asking Buildbucket for the build status
[04:17:17.071] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:17.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:49:0) after 1m0s
[04:18:17.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:49:0)
[04:18:17.283] Timer tick, asking Buildbucket for the build status
[04:18:17.555] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:17.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:50:0) after 1m0s
[04:19:17.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:50:0)
[04:19:17.712] Timer tick, asking Buildbucket for the build status
[04:19:17.874] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:17.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:51:0) after 1m0s
[04:20:17.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:51:0)
[04:20:17.998] Timer tick, asking Buildbucket for the build status
[04:20:18.369] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:18.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:52:0) after 1m0s
[04:21:18.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:52:0)
[04:21:18.581] Timer tick, asking Buildbucket for the build status
[04:21:18.771] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:18.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:53:0) after 1m0s
[04:22:18.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:53:0)
[04:22:18.872] Timer tick, asking Buildbucket for the build status
[04:22:19.013] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:19.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:54:0) after 1m0s
[04:23:19.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:54:0)
[04:23:19.156] Timer tick, asking Buildbucket for the build status
[04:23:19.358] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:19.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:55:0) after 1m0s
[04:24:19.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:55:0)
[04:24:19.566] Timer tick, asking Buildbucket for the build status
[04:24:19.759] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:19.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:56:0) after 1m0s
[04:25:19.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:56:0)
[04:25:19.855] Timer tick, asking Buildbucket for the build status
[04:25:20.046] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:20.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:57:0) after 1m0s
[04:26:20.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:57:0)
[04:26:20.141] Timer tick, asking Buildbucket for the build status
[04:26:21.226] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:21.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:58:0) after 1m0s
[04:27:21.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:58:0)
[04:27:21.223] Timer tick, asking Buildbucket for the build status
[04:27:22.203] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:22.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:59:0) after 1m0s
[04:28:22.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:59:0)
[04:28:22.388] Timer tick, asking Buildbucket for the build status
[04:28:22.546] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:22.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:60:0) after 1m0s
[04:29:22.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:60:0)
[04:29:22.831] Timer tick, asking Buildbucket for the build status
[04:29:23.166] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:23.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:61:0) after 1m0s
[04:30:23.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:61:0)
[04:30:23.252] Timer tick, asking Buildbucket for the build status
[04:30:23.531] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:23.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:62:0) after 1m0s
[04:31:23.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:62:0)
[04:31:23.777] Timer tick, asking Buildbucket for the build status
[04:31:23.951] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:23.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:63:0) after 1m0s
[04:32:24.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:63:0)
[04:32:24.098] Timer tick, asking Buildbucket for the build status
[04:32:24.263] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:24.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:64:0) after 1m0s
[04:33:24.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:64:0)
[04:33:24.280] Timer tick, asking Buildbucket for the build status
[04:33:25.911] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:25.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:65:0) after 1m0s
[04:34:25.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:65:0)
[04:34:25.977] Timer tick, asking Buildbucket for the build status
[04:34:26.155] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:26.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:66:0) after 1m0s
[04:35:26.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:66:0)
[04:35:26.228] Timer tick, asking Buildbucket for the build status
[04:35:26.380] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:26.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:67:0) after 1m0s
[04:36:26.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:67:0)
[04:36:26.486] Timer tick, asking Buildbucket for the build status
[04:36:26.659] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:26.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:68:0) after 1m0s
[04:37:26.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:68:0)
[04:37:26.856] Timer tick, asking Buildbucket for the build status
[04:37:27.025] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:27.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:69:0) after 1m0s
[04:38:27.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:69:0)
[04:38:27.374] Timer tick, asking Buildbucket for the build status
[04:38:27.513] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:27.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:70:0) after 1m0s
[04:39:27.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:70:0)
[04:39:27.737] Timer tick, asking Buildbucket for the build status
[04:39:27.864] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:27.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:71:0) after 1m0s
[04:40:27.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:71:0)
[04:40:27.958] Timer tick, asking Buildbucket for the build status
[04:40:28.197] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:28.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:72:0) after 1m0s
[04:41:28.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:72:0)
[04:41:28.368] Timer tick, asking Buildbucket for the build status
[04:41:28.662] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:28.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:73:0) after 1m0s
[04:42:28.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:73:0)
[04:42:28.766] Timer tick, asking Buildbucket for the build status
[04:42:28.928] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:28.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:74:0) after 1m0s
[04:43:29.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:74:0)
[04:43:29.016] Timer tick, asking Buildbucket for the build status
[04:43:30.980] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:30.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:75:0) after 1m0s
[04:44:31.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:75:0)
[04:44:31.291] Timer tick, asking Buildbucket for the build status
[04:44:31.963] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:31.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:76:0) after 1m0s
[04:45:31.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:76:0)
[04:45:31.979] Timer tick, asking Buildbucket for the build status
[04:45:32.478] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:32.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:77:0) after 1m0s
[04:46:32.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:77:0)
[04:46:32.556] Timer tick, asking Buildbucket for the build status
[04:46:32.713] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:32.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:78:0) after 1m0s
[04:47:32.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:78:0)
[04:47:32.798] Timer tick, asking Buildbucket for the build status
[04:47:32.958] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:32.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:79:0) after 1m0s
[04:48:32.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:79:0)
[04:48:32.956] Timer tick, asking Buildbucket for the build status
[04:48:33.984] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:33.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:80:0) after 1m0s
[04:49:34.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:80:0)
[04:49:34.167] Timer tick, asking Buildbucket for the build status
[04:49:34.491] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:34.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:81:0) after 1m0s
[04:50:34.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:81:0)
[04:50:34.585] Timer tick, asking Buildbucket for the build status
[04:50:34.790] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:34.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:82:0) after 1m0s
[04:51:34.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:82:0)
[04:51:34.826] Timer tick, asking Buildbucket for the build status
[04:51:35.222] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:35.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:83:0) after 1m0s
[04:52:35.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:83:0)
[04:52:35.282] Timer tick, asking Buildbucket for the build status
[04:52:35.435] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:35.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:84:0) after 1m0s
[04:53:35.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:84:0)
[04:53:35.456] Timer tick, asking Buildbucket for the build status
[04:53:35.723] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:35.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:85:0) after 1m0s
[04:54:35.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:85:0)
[04:54:35.785] Timer tick, asking Buildbucket for the build status
[04:54:35.920] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:35.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:86:0) after 1m0s
[04:55:35.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:86:0)
[04:55:35.983] Timer tick, asking Buildbucket for the build status
[04:55:36.369] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:36.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:87:0) after 1m0s
[04:56:36.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:87:0)
[04:56:36.418] Timer tick, asking Buildbucket for the build status
[04:56:36.930] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:36.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:88:0) after 1m0s
[04:57:37.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:88:0)
[04:57:37.028] Timer tick, asking Buildbucket for the build status
[04:57:37.218] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:37.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:89:0) after 1m0s
[04:58:37.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:89:0)
[04:58:37.435] Timer tick, asking Buildbucket for the build status
[04:58:38.205] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:38.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:90:0) after 1m0s
[04:59:38.360] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:90:0)
[04:59:38.360] Timer tick, asking Buildbucket for the build status
[04:59:38.569] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:38.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:91:0) after 1m0s
[05:00:38.594] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:91:0)
[05:00:38.594] Timer tick, asking Buildbucket for the build status
[05:00:38.868] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:38.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:92:0) after 1m0s
[05:01:38.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:92:0)
[05:01:38.922] Timer tick, asking Buildbucket for the build status
[05:01:39.186] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:39.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:93:0) after 1m0s
[05:02:39.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:93:0)
[05:02:39.223] Timer tick, asking Buildbucket for the build status
[05:02:39.373] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:39.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:94:0) after 1m0s
[05:03:39.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:94:0)
[05:03:39.426] Timer tick, asking Buildbucket for the build status
[05:03:39.720] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:39.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:95:0) after 1m0s
[05:04:39.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:95:0)
[05:04:39.713] Timer tick, asking Buildbucket for the build status
[05:04:40.013] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:40.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:96:0) after 1m0s
[05:05:40.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:96:0)
[05:05:40.000] Timer tick, asking Buildbucket for the build status
[05:05:40.145] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:40.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:97:0) after 1m0s
[05:06:40.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:97:0)
[05:06:40.157] Timer tick, asking Buildbucket for the build status
[05:06:40.302] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:40.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:98:0) after 1m0s
[05:07:40.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:98:0)
[05:07:40.406] Timer tick, asking Buildbucket for the build status
[05:07:40.660] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:40.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:99:0) after 1m0s
[05:08:40.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:99:0)
[05:08:40.743] Timer tick, asking Buildbucket for the build status
[05:08:41.406] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:41.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:100:0) after 1m0s
[05:09:41.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:100:0)
[05:09:41.433] Timer tick, asking Buildbucket for the build status
[05:09:41.820] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:41.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:101:0) after 1m0s
[05:10:41.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:101:0)
[05:10:41.859] Timer tick, asking Buildbucket for the build status
[05:10:41.976] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:41.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:102:0) after 1m0s
[05:11:42.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:102:0)
[05:11:42.037] Timer tick, asking Buildbucket for the build status
[05:11:42.375] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:42.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:103:0) after 1m0s
[05:12:42.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:103:0)
[05:12:42.373] Timer tick, asking Buildbucket for the build status
[05:12:42.541] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:42.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:104:0) after 1m0s
[05:13:42.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:104:0)
[05:13:42.591] Timer tick, asking Buildbucket for the build status
[05:13:42.829] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:42.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:105:0) after 1m0s
[05:14:42.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:105:0)
[05:14:42.915] Timer tick, asking Buildbucket for the build status
[05:14:43.959] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:43.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:106:0) after 1m0s
[05:15:44.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:106:0)
[05:15:44.020] Timer tick, asking Buildbucket for the build status
[05:15:44.385] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:44.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:107:0) after 1m0s
[05:16:44.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:107:0)
[05:16:44.439] Timer tick, asking Buildbucket for the build status
[05:16:44.659] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:44.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:108:0) after 1m0s
[05:17:44.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:108:0)
[05:17:44.709] Timer tick, asking Buildbucket for the build status
[05:17:45.101] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:45.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:109:0) after 1m0s
[05:18:45.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:109:0)
[05:18:45.139] Timer tick, asking Buildbucket for the build status
[05:18:45.565] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:45.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:110:0) after 1m0s
[05:19:45.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:110:0)
[05:19:45.797] Timer tick, asking Buildbucket for the build status
[05:19:46.157] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:46.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:111:0) after 1m0s
[05:20:46.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:111:0)
[05:20:46.266] Timer tick, asking Buildbucket for the build status
[05:20:46.615] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:46.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:112:0) after 1m0s
[05:21:46.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:112:0)
[05:21:46.669] Timer tick, asking Buildbucket for the build status
[05:21:46.780] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:46.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:113:0) after 1m0s
[05:22:46.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:113:0)
[05:22:46.868] Timer tick, asking Buildbucket for the build status
[05:22:47.000] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:47.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:114:0) after 1m0s
[05:23:47.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:114:0)
[05:23:47.044] Timer tick, asking Buildbucket for the build status
[05:23:47.257] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:47.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:115:0) after 1m0s
[05:24:47.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:115:0)
[05:24:47.310] Timer tick, asking Buildbucket for the build status
[05:24:47.633] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:47.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:116:0) after 1m0s
[05:25:47.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:116:0)
[05:25:47.677] Timer tick, asking Buildbucket for the build status
[05:25:47.844] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:47.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:117:0) after 1m0s
[05:26:47.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:117:0)
[05:26:47.855] Timer tick, asking Buildbucket for the build status
[05:26:48.014] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:48.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:118:0) after 1m0s
[05:27:48.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:118:0)
[05:27:48.035] Timer tick, asking Buildbucket for the build status
[05:27:48.222] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:48.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:119:0) after 1m0s
[05:28:48.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:119:0)
[05:28:48.277] Timer tick, asking Buildbucket for the build status
[05:28:48.783] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:48.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:120:0) after 1m0s
[05:29:48.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:120:0)
[05:29:48.805] Timer tick, asking Buildbucket for the build status
[05:29:48.985] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:48.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:121:0) after 1m0s
[05:30:49.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:121:0)
[05:30:49.012] Timer tick, asking Buildbucket for the build status
[05:30:49.235] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:49.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:122:0) after 1m0s
[05:31:49.260] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:122:0)
[05:31:49.260] Timer tick, asking Buildbucket for the build status
[05:31:49.411] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:49.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:123:0) after 1m0s
[05:32:49.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:123:0)
[05:32:49.489] Timer tick, asking Buildbucket for the build status
[05:32:49.921] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:49.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:124:0) after 1m0s
[05:33:49.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:124:0)
[05:33:49.949] Timer tick, asking Buildbucket for the build status
[05:33:51.477] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:51.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:125:0) after 1m0s
[05:34:51.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:125:0)
[05:34:51.546] Timer tick, asking Buildbucket for the build status
[05:34:51.724] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:51.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:126:0) after 1m0s
[05:35:51.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:126:0)
[05:35:51.766] Timer tick, asking Buildbucket for the build status
[05:35:52.029] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:52.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:127:0) after 1m0s
[05:36:52.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:127:0)
[05:36:52.088] Timer tick, asking Buildbucket for the build status
[05:36:52.576] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:52.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:128:0) after 1m0s
[05:37:52.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:128:0)
[05:37:52.595] Timer tick, asking Buildbucket for the build status
[05:37:53.134] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:53.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:129:0) after 1m0s
[05:38:53.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:129:0)
[05:38:53.163] Timer tick, asking Buildbucket for the build status
[05:38:53.317] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:53.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:130:0) after 1m0s
[05:39:53.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:130:0)
[05:39:53.355] Timer tick, asking Buildbucket for the build status
[05:39:53.744] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:53.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:131:0) after 1m0s
[05:40:53.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:131:0)
[05:40:53.780] Timer tick, asking Buildbucket for the build status
[05:40:53.890] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:53.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:132:0) after 1m0s
[05:41:53.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:132:0)
[05:41:53.916] Timer tick, asking Buildbucket for the build status
[05:41:54.483] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:54.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:133:0) after 1m0s
[05:42:54.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:133:0)
[05:42:54.508] Timer tick, asking Buildbucket for the build status
[05:42:54.694] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:54.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:134:0) after 1m0s
[05:43:54.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:134:0)
[05:43:54.718] Timer tick, asking Buildbucket for the build status
[05:43:56.360] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:56.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:135:0) after 1m0s
[05:44:56.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:135:0)
[05:44:56.470] Timer tick, asking Buildbucket for the build status
[05:44:56.654] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:56.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:136:0) after 1m0s
[05:45:56.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:136:0)
[05:45:56.712] Timer tick, asking Buildbucket for the build status
[05:45:56.941] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:56.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:137:0) after 1m0s
[05:46:56.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:137:0)
[05:46:56.983] Timer tick, asking Buildbucket for the build status
[05:46:57.174] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:57.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:138:0) after 1m0s
[05:47:57.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:138:0)
[05:47:57.213] Timer tick, asking Buildbucket for the build status
[05:47:57.358] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:57.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:139:0) after 1m0s
[05:48:57.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:139:0)
[05:48:57.412] Timer tick, asking Buildbucket for the build status
[05:48:57.588] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:57.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:140:0) after 1m0s
[05:49:57.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:140:0)
[05:49:57.618] Timer tick, asking Buildbucket for the build status
[05:49:58.113] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:58.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:141:0) after 1m0s
[05:50:58.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:141:0)
[05:50:58.289] Timer tick, asking Buildbucket for the build status
[05:50:58.488] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:58.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:142:0) after 1m0s
[05:51:58.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:142:0)
[05:51:58.513] Timer tick, asking Buildbucket for the build status
[05:51:58.669] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:58.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:143:0) after 1m0s
[05:52:58.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:143:0)
[05:52:58.732] Timer tick, asking Buildbucket for the build status
[05:52:59.009] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:59.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:144:0) after 1m0s
[05:53:59.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:144:0)
[05:53:59.127] Timer tick, asking Buildbucket for the build status
[05:53:59.982] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:59.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:145:0) after 1m0s
[05:55:00.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:145:0)
[05:55:00.009] Timer tick, asking Buildbucket for the build status
[05:55:00.400] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:00.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:146:0) after 1m0s
[05:56:00.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:146:0)
[05:56:00.450] Timer tick, asking Buildbucket for the build status
[05:56:00.633] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:00.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:147:0) after 1m0s
[05:57:00.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:147:0)
[05:57:00.732] Timer tick, asking Buildbucket for the build status
[05:57:01.115] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:01.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:148:0) after 1m0s
[05:58:01.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:148:0)
[05:58:01.142] Timer tick, asking Buildbucket for the build status
[05:58:01.301] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:01.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:149:0) after 1m0s
[05:59:01.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:149:0)
[05:59:01.417] Timer tick, asking Buildbucket for the build status
[05:59:01.762] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:01.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:150:0) after 1m0s
[06:00:01.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:150:0)
[06:00:01.811] Timer tick, asking Buildbucket for the build status
[06:00:01.975] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:01.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:151:0) after 1m0s
[06:01:01.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:151:0)
[06:01:01.997] Timer tick, asking Buildbucket for the build status
[06:01:02.123] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:02.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:152:0) after 1m0s
[06:02:02.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:152:0)
[06:02:02.197] Timer tick, asking Buildbucket for the build status
[06:02:03.525] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:03.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:153:0) after 1m0s
[06:03:03.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:153:0)
[06:03:03.554] Timer tick, asking Buildbucket for the build status
[06:03:03.800] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:03.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:154:0) after 1m0s
[06:04:03.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:154:0)
[06:04:03.838] Timer tick, asking Buildbucket for the build status
[06:04:04.247] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:04.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:155:0) after 1m0s
[06:05:04.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:155:0)
[06:05:04.279] Timer tick, asking Buildbucket for the build status
[06:05:04.873] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:04.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:156:0) after 1m0s
[06:06:04.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:156:0)
[06:06:04.909] Timer tick, asking Buildbucket for the build status
[06:06:05.035] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:05.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:157:0) after 1m0s
[06:07:05.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:157:0)
[06:07:05.046] Timer tick, asking Buildbucket for the build status
[06:07:05.302] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:05.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:158:0) after 1m0s
[06:08:05.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:158:0)
[06:08:05.327] Timer tick, asking Buildbucket for the build status
[06:08:06.004] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:06.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:159:0) after 1m0s
[06:09:06.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:159:0)
[06:09:06.111] Timer tick, asking Buildbucket for the build status
[06:09:06.732] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:06.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:160:0) after 1m0s
[06:10:06.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:160:0)
[06:10:06.902] Timer tick, asking Buildbucket for the build status
[06:10:07.898] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:07.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:161:0) after 1m0s
[06:11:07.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:161:0)
[06:11:07.911] Timer tick, asking Buildbucket for the build status
[06:11:08.091] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:08.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:162:0) after 1m0s
[06:12:08.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:162:0)
[06:12:08.163] Timer tick, asking Buildbucket for the build status
[06:12:08.361] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:08.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:163:0) after 1m0s
[06:13:08.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:163:0)
[06:13:08.434] Timer tick, asking Buildbucket for the build status
[06:13:08.535] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:08.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:164:0) after 1m0s
[06:14:08.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:164:0)
[06:14:08.634] Timer tick, asking Buildbucket for the build status
[06:14:08.851] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:08.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:165:0) after 1m0s
[06:15:08.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:165:0)
[06:15:08.919] Timer tick, asking Buildbucket for the build status
[06:15:09.451] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:09.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:166:0) after 1m0s
[06:16:09.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:166:0)
[06:16:09.598] Timer tick, asking Buildbucket for the build status
[06:16:09.951] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:09.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:167:0) after 1m0s
[06:17:10.030] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:167:0)
[06:17:10.030] Timer tick, asking Buildbucket for the build status
[06:17:10.248] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:10.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:168:0) after 1m0s
[06:18:10.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:168:0)
[06:18:10.316] Timer tick, asking Buildbucket for the build status
[06:18:10.549] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:10.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:169:0) after 1m0s
[06:19:10.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:169:0)
[06:19:10.594] Timer tick, asking Buildbucket for the build status
[06:19:10.795] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:10.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:170:0) after 1m0s
[06:20:10.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:170:0)
[06:20:10.915] Timer tick, asking Buildbucket for the build status
[06:20:11.236] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:11.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:171:0) after 1m0s
[06:21:11.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:171:0)
[06:21:11.336] Timer tick, asking Buildbucket for the build status
[06:21:11.451] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:11.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:172:0) after 1m0s
[06:22:11.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:172:0)
[06:22:11.528] Timer tick, asking Buildbucket for the build status
[06:22:11.700] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:11.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:173:0) after 1m0s
[06:23:11.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:173:0)
[06:23:11.857] Timer tick, asking Buildbucket for the build status
[06:23:11.989] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:11.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:174:0) after 1m0s
[06:24:12.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:174:0)
[06:24:12.109] Timer tick, asking Buildbucket for the build status
[06:24:12.698] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:12.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:175:0) after 1m0s
[06:25:12.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:175:0)
[06:25:12.725] Timer tick, asking Buildbucket for the build status
[06:25:12.869] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:12.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:176:0) after 1m0s
[06:26:12.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:176:0)
[06:26:12.900] Timer tick, asking Buildbucket for the build status
[06:26:13.055] Build 8877097166865242976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:13.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042527228943093296:177:0) after 1m0s
[06:26:42.386] Received PubSub notification, asking Buildbucket for the build status
[06:26:42.495] Build 8877097166865242976: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:26:42.495] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1592548001483193",
    "created_by": "project:infra",
    "created_ts": "1592537449925700",
    "id": "8877097166865242976",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4147.56\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9ad13da5-17e5-4008-9e9a-963f0194f765\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4147.56\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"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-60qb\"], \"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": "1592537505309007",
    "status": "COMPLETED",
    "status_changed_ts": "1592548001956756",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9042527228943093296",
      "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/8877097166865242976/+/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:4ce372937d413910",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1592548002085801",
    "url": "https://ci.chromium.org/b/8877097166865242976",
    "utcnow_ts": "1592548002485430"
  }
}
[06:26:42.495] Invocation finished in 2h55m53.934861544s with status SUCCEEDED