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

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

{
  "version": "88.0.4324.186"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[08:37:42.707] New invocation is queued and will start shortly
[08:37:42.707] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:37:43.943] Starting the invocation (attempt 1)
[08:37:44.000] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:37:44.002] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:37:44.002] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9020402260526436080",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4324.186\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"9d137493-ab84-4ee6-894e-f7d32c4e6a88\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4324.186\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9020402260526436080",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:37:44.517] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:infra",
    "created_ts": "1613637464103361",
    "id": "8854972198398646576",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4324.186\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9d137493-ab84-4ee6-894e-f7d32c4e6a88\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4324.186\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1613637464286460",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9020402260526436080",
      "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/8854972198398646576/+/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": "1613637464286628",
    "url": "https://ci.chromium.org/b/8854972198398646576",
    "utcnow_ts": "1613637464506343"
  }
}
[08:37:44.517] Task URL: https://ci.chromium.org/b/8854972198398646576
[08:37:44.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:2:0) after 1m0s
[08:38:10.852] Received PubSub notification, asking Buildbucket for the build status
[08:38:10.945] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:44.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:2:0)
[08:38:44.648] Timer tick, asking Buildbucket for the build status
[08:38:44.757] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:44.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:4:0) after 1m0s
[08:39:44.869] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:4:0)
[08:39:44.869] Timer tick, asking Buildbucket for the build status
[08:39:44.939] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:44.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:5:0) after 1m0s
[08:40:44.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:5:0)
[08:40:44.914] Timer tick, asking Buildbucket for the build status
[08:40:45.113] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:45.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:6:0) after 1m0s
[08:41:45.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:6:0)
[08:41:45.134] Timer tick, asking Buildbucket for the build status
[08:41:45.233] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:45.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:7:0) after 1m0s
[08:42:45.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:7:0)
[08:42:45.287] Timer tick, asking Buildbucket for the build status
[08:42:45.425] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:45.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:8:0) after 1m0s
[08:43:45.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:8:0)
[08:43:45.433] Timer tick, asking Buildbucket for the build status
[08:43:45.657] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:45.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:9:0) after 1m0s
[08:44:45.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:9:0)
[08:44:45.780] Timer tick, asking Buildbucket for the build status
[08:44:45.862] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:45.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:10:0) after 1m0s
[08:45:45.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:10:0)
[08:45:45.910] Timer tick, asking Buildbucket for the build status
[08:45:46.058] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:46.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:11:0) after 1m0s
[08:46:46.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:11:0)
[08:46:46.085] Timer tick, asking Buildbucket for the build status
[08:46:46.152] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:46.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:12:0) after 1m0s
[08:47:46.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:12:0)
[08:47:46.175] Timer tick, asking Buildbucket for the build status
[08:47:46.251] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:46.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:13:0) after 1m0s
[08:48:46.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:13:0)
[08:48:46.273] Timer tick, asking Buildbucket for the build status
[08:48:46.475] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:46.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:14:0) after 1m0s
[08:49:46.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:14:0)
[08:49:46.508] Timer tick, asking Buildbucket for the build status
[08:49:46.592] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:46.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:15:0) after 1m0s
[08:50:46.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:15:0)
[08:50:46.636] Timer tick, asking Buildbucket for the build status
[08:50:46.702] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:46.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:16:0) after 1m0s
[08:51:46.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:16:0)
[08:51:46.720] Timer tick, asking Buildbucket for the build status
[08:51:46.799] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:46.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:17:0) after 1m0s
[08:52:46.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:17:0)
[08:52:46.843] Timer tick, asking Buildbucket for the build status
[08:52:46.912] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:46.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:18:0) after 1m0s
[08:53:46.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:18:0)
[08:53:46.980] Timer tick, asking Buildbucket for the build status
[08:53:47.082] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:47.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:19:0) after 1m0s
[08:54:47.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:19:0)
[08:54:47.245] Timer tick, asking Buildbucket for the build status
[08:54:47.320] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:47.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:20:0) after 1m0s
[08:55:47.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:20:0)
[08:55:47.370] Timer tick, asking Buildbucket for the build status
[08:55:47.446] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:47.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:21:0) after 1m0s
[08:56:47.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:21:0)
[08:56:47.471] Timer tick, asking Buildbucket for the build status
[08:56:47.573] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:47.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:22:0) after 1m0s
[08:57:47.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:22:0)
[08:57:47.596] Timer tick, asking Buildbucket for the build status
[08:57:47.700] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:47.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:23:0) after 1m0s
[08:58:47.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:23:0)
[08:58:47.884] Timer tick, asking Buildbucket for the build status
[08:58:47.954] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:47.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:24:0) after 1m0s
[08:59:48.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:24:0)
[08:59:48.091] Timer tick, asking Buildbucket for the build status
[08:59:48.164] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:48.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:25:0) after 1m0s
[09:00:48.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:25:0)
[09:00:48.189] Timer tick, asking Buildbucket for the build status
[09:00:48.271] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:48.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:26:0) after 1m0s
[09:01:48.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:26:0)
[09:01:48.365] Timer tick, asking Buildbucket for the build status
[09:01:48.449] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:48.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:27:0) after 1m0s
[09:02:48.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:27:0)
[09:02:48.529] Timer tick, asking Buildbucket for the build status
[09:02:48.676] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:48.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:28:0) after 1m0s
[09:03:48.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:28:0)
[09:03:48.780] Timer tick, asking Buildbucket for the build status
[09:03:48.858] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:48.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:29:0) after 1m0s
[09:04:48.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:29:0)
[09:04:48.894] Timer tick, asking Buildbucket for the build status
[09:04:48.966] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:48.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:30:0) after 1m0s
[09:05:49.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:30:0)
[09:05:49.070] Timer tick, asking Buildbucket for the build status
[09:05:49.200] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:49.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:31:0) after 1m0s
[09:06:49.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:31:0)
[09:06:49.272] Timer tick, asking Buildbucket for the build status
[09:06:49.334] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:49.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:32:0) after 1m0s
[09:07:49.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:32:0)
[09:07:49.315] Timer tick, asking Buildbucket for the build status
[09:07:49.400] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:49.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:33:0) after 1m0s
[09:08:49.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:33:0)
[09:08:49.421] Timer tick, asking Buildbucket for the build status
[09:08:51.013] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:51.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:34:0) after 1m0s
[09:09:51.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:34:0)
[09:09:51.035] Timer tick, asking Buildbucket for the build status
[09:09:51.119] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:51.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:35:0) after 1m0s
[09:10:51.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:35:0)
[09:10:51.231] Timer tick, asking Buildbucket for the build status
[09:10:51.305] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:51.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:36:0) after 1m0s
[09:11:51.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:36:0)
[09:11:51.364] Timer tick, asking Buildbucket for the build status
[09:11:51.456] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:51.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:37:0) after 1m0s
[09:12:51.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:37:0)
[09:12:51.566] Timer tick, asking Buildbucket for the build status
[09:12:51.716] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:51.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:38:0) after 1m0s
[09:13:51.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:38:0)
[09:13:51.757] Timer tick, asking Buildbucket for the build status
[09:13:52.103] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:52.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:39:0) after 1m0s
[09:14:52.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:39:0)
[09:14:52.110] Timer tick, asking Buildbucket for the build status
[09:14:52.183] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:52.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:40:0) after 1m0s
[09:15:52.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:40:0)
[09:15:52.203] Timer tick, asking Buildbucket for the build status
[09:15:52.279] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:52.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:41:0) after 1m0s
[09:16:52.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:41:0)
[09:16:52.282] Timer tick, asking Buildbucket for the build status
[09:16:52.366] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:52.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:42:0) after 1m0s
[09:17:52.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:42:0)
[09:17:52.378] Timer tick, asking Buildbucket for the build status
[09:17:52.502] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:52.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:43:0) after 1m0s
[09:18:52.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:43:0)
[09:18:52.573] Timer tick, asking Buildbucket for the build status
[09:18:52.645] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:52.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:44:0) after 1m0s
[09:19:52.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:44:0)
[09:19:52.687] Timer tick, asking Buildbucket for the build status
[09:19:52.816] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:52.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:45:0) after 1m0s
[09:20:52.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:45:0)
[09:20:52.838] Timer tick, asking Buildbucket for the build status
[09:20:52.908] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:52.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:46:0) after 1m0s
[09:21:53.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:46:0)
[09:21:53.012] Timer tick, asking Buildbucket for the build status
[09:21:53.323] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:53.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:47:0) after 1m0s
[09:22:53.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:47:0)
[09:22:53.352] Timer tick, asking Buildbucket for the build status
[09:22:53.600] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:53.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:48:0) after 1m0s
[09:23:53.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:48:0)
[09:23:53.619] Timer tick, asking Buildbucket for the build status
[09:23:53.730] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:53.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:49:0) after 1m0s
[09:24:53.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:49:0)
[09:24:53.757] Timer tick, asking Buildbucket for the build status
[09:24:54.129] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:54.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:50:0) after 1m0s
[09:25:54.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:50:0)
[09:25:54.163] Timer tick, asking Buildbucket for the build status
[09:25:54.500] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:54.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:51:0) after 1m0s
[09:26:54.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:51:0)
[09:26:54.624] Timer tick, asking Buildbucket for the build status
[09:26:54.712] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:54.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:52:0) after 1m0s
[09:27:54.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:52:0)
[09:27:54.746] Timer tick, asking Buildbucket for the build status
[09:27:54.823] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:54.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:53:0) after 1m0s
[09:28:54.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:53:0)
[09:28:54.907] Timer tick, asking Buildbucket for the build status
[09:28:55.000] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:55.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:54:0) after 1m0s
[09:29:55.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:54:0)
[09:29:55.033] Timer tick, asking Buildbucket for the build status
[09:29:55.473] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:55.473] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:55:0) after 1m0s
[09:30:55.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:55:0)
[09:30:55.576] Timer tick, asking Buildbucket for the build status
[09:30:55.662] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:55.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:56:0) after 1m0s
[09:31:55.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:56:0)
[09:31:55.669] Timer tick, asking Buildbucket for the build status
[09:31:55.745] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:55.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:57:0) after 1m0s
[09:32:55.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:57:0)
[09:32:55.812] Timer tick, asking Buildbucket for the build status
[09:32:56.038] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:56.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:58:0) after 1m0s
[09:33:56.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:58:0)
[09:33:56.128] Timer tick, asking Buildbucket for the build status
[09:33:56.199] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:56.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:59:0) after 1m0s
[09:34:56.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:59:0)
[09:34:56.252] Timer tick, asking Buildbucket for the build status
[09:34:56.324] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:56.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:60:0) after 1m0s
[09:35:56.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:60:0)
[09:35:56.426] Timer tick, asking Buildbucket for the build status
[09:35:56.485] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:56.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:61:0) after 1m0s
[09:36:56.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:61:0)
[09:36:56.535] Timer tick, asking Buildbucket for the build status
[09:36:56.616] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:56.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:62:0) after 1m0s
[09:37:56.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:62:0)
[09:37:56.703] Timer tick, asking Buildbucket for the build status
[09:37:56.940] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:56.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:63:0) after 1m0s
[09:38:56.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:63:0)
[09:38:56.952] Timer tick, asking Buildbucket for the build status
[09:38:57.031] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:57.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:64:0) after 1m0s
[09:39:57.050] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:64:0)
[09:39:57.050] Timer tick, asking Buildbucket for the build status
[09:39:57.212] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:57.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:65:0) after 1m0s
[09:40:57.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:65:0)
[09:40:57.213] Timer tick, asking Buildbucket for the build status
[09:40:57.281] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:57.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:66:0) after 1m0s
[09:41:57.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:66:0)
[09:41:57.341] Timer tick, asking Buildbucket for the build status
[09:41:57.414] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:57.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:67:0) after 1m0s
[09:42:57.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:67:0)
[09:42:57.401] Timer tick, asking Buildbucket for the build status
[09:42:57.526] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:57.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:68:0) after 1m0s
[09:43:57.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:68:0)
[09:43:57.602] Timer tick, asking Buildbucket for the build status
[09:43:57.962] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:57.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:69:0) after 1m0s
[09:44:57.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:69:0)
[09:44:57.955] Timer tick, asking Buildbucket for the build status
[09:44:58.028] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:58.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:70:0) after 1m0s
[09:45:58.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:70:0)
[09:45:58.071] Timer tick, asking Buildbucket for the build status
[09:45:58.163] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:58.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:71:0) after 1m0s
[09:46:58.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:71:0)
[09:46:58.264] Timer tick, asking Buildbucket for the build status
[09:46:58.345] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:58.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:72:0) after 1m0s
[09:47:58.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:72:0)
[09:47:58.397] Timer tick, asking Buildbucket for the build status
[09:47:58.728] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:58.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:73:0) after 1m0s
[09:48:58.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:73:0)
[09:48:58.847] Timer tick, asking Buildbucket for the build status
[09:48:58.954] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:58.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:74:0) after 1m0s
[09:49:59.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:74:0)
[09:49:59.066] Timer tick, asking Buildbucket for the build status
[09:49:59.196] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:59.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:75:0) after 1m0s
[09:50:59.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:75:0)
[09:50:59.240] Timer tick, asking Buildbucket for the build status
[09:50:59.334] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:59.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:76:0) after 1m0s
[09:51:59.491] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:76:0)
[09:51:59.491] Timer tick, asking Buildbucket for the build status
[09:51:59.578] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:59.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:77:0) after 1m0s
[09:52:59.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:77:0)
[09:52:59.707] Timer tick, asking Buildbucket for the build status
[09:52:59.810] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:59.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:78:0) after 1m0s
[09:54:00.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:78:0)
[09:54:00.007] Timer tick, asking Buildbucket for the build status
[09:54:00.224] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:00.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:79:0) after 1m0s
[09:55:00.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:79:0)
[09:55:00.257] Timer tick, asking Buildbucket for the build status
[09:55:00.328] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:00.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:80:0) after 1m0s
[09:56:00.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:80:0)
[09:56:00.380] Timer tick, asking Buildbucket for the build status
[09:56:00.690] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:00.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:81:0) after 1m0s
[09:57:00.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:81:0)
[09:57:00.712] Timer tick, asking Buildbucket for the build status
[09:57:00.781] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:00.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:82:0) after 1m0s
[09:58:00.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:82:0)
[09:58:00.902] Timer tick, asking Buildbucket for the build status
[09:58:01.018] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:01.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:83:0) after 1m0s
[09:59:01.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:83:0)
[09:59:01.216] Timer tick, asking Buildbucket for the build status
[09:59:01.289] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:01.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:84:0) after 1m0s
[10:00:01.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:84:0)
[10:00:01.530] Timer tick, asking Buildbucket for the build status
[10:00:01.602] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:01.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:85:0) after 1m0s
[10:01:02.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:85:0)
[10:01:02.115] Timer tick, asking Buildbucket for the build status
[10:01:02.193] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:02.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:86:0) after 1m0s
[10:02:02.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:86:0)
[10:02:02.249] Timer tick, asking Buildbucket for the build status
[10:02:02.440] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:02.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:87:0) after 1m0s
[10:03:02.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:87:0)
[10:03:02.508] Timer tick, asking Buildbucket for the build status
[10:03:02.627] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:02.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:88:0) after 1m0s
[10:04:02.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:88:0)
[10:04:02.741] Timer tick, asking Buildbucket for the build status
[10:04:02.941] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:02.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:89:0) after 1m0s
[10:05:02.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:89:0)
[10:05:02.970] Timer tick, asking Buildbucket for the build status
[10:05:03.061] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:03.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:90:0) after 1m0s
[10:06:03.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:90:0)
[10:06:03.179] Timer tick, asking Buildbucket for the build status
[10:06:03.302] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:03.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:91:0) after 1m0s
[10:07:03.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:91:0)
[10:07:03.642] Timer tick, asking Buildbucket for the build status
[10:07:03.750] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:03.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:92:0) after 1m0s
[10:08:03.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:92:0)
[10:08:03.821] Timer tick, asking Buildbucket for the build status
[10:08:03.962] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:03.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:93:0) after 1m0s
[10:09:04.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:93:0)
[10:09:04.067] Timer tick, asking Buildbucket for the build status
[10:09:04.151] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:04.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:94:0) after 1m0s
[10:10:04.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:94:0)
[10:10:04.344] Timer tick, asking Buildbucket for the build status
[10:10:04.460] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:04.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:95:0) after 1m0s
[10:11:04.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:95:0)
[10:11:04.565] Timer tick, asking Buildbucket for the build status
[10:11:04.660] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:04.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:96:0) after 1m0s
[10:12:04.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:96:0)
[10:12:04.742] Timer tick, asking Buildbucket for the build status
[10:12:05.023] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:05.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:97:0) after 1m0s
[10:13:05.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:97:0)
[10:13:05.064] Timer tick, asking Buildbucket for the build status
[10:13:05.139] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:05.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:98:0) after 1m0s
[10:14:05.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:98:0)
[10:14:05.174] Timer tick, asking Buildbucket for the build status
[10:14:05.501] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:05.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:99:0) after 1m0s
[10:15:05.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:99:0)
[10:15:05.522] Timer tick, asking Buildbucket for the build status
[10:15:05.601] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:05.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:100:0) after 1m0s
[10:16:05.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:100:0)
[10:16:05.739] Timer tick, asking Buildbucket for the build status
[10:16:05.821] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:05.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:101:0) after 1m0s
[10:17:05.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:101:0)
[10:17:05.924] Timer tick, asking Buildbucket for the build status
[10:17:05.997] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:05.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:102:0) after 1m0s
[10:18:06.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:102:0)
[10:18:06.048] Timer tick, asking Buildbucket for the build status
[10:18:06.347] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:06.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:103:0) after 1m0s
[10:19:06.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:103:0)
[10:19:06.425] Timer tick, asking Buildbucket for the build status
[10:19:06.507] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:06.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:104:0) after 1m0s
[10:20:06.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:104:0)
[10:20:06.654] Timer tick, asking Buildbucket for the build status
[10:20:06.728] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:06.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:105:0) after 1m0s
[10:21:06.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:105:0)
[10:21:06.746] Timer tick, asking Buildbucket for the build status
[10:21:06.893] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:06.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:106:0) after 1m0s
[10:22:07.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:106:0)
[10:22:07.029] Timer tick, asking Buildbucket for the build status
[10:22:07.094] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:07.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:107:0) after 1m0s
[10:23:07.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:107:0)
[10:23:07.137] Timer tick, asking Buildbucket for the build status
[10:23:07.374] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:07.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:108:0) after 1m0s
[10:24:07.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:108:0)
[10:24:07.454] Timer tick, asking Buildbucket for the build status
[10:24:07.621] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:07.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:109:0) after 1m0s
[10:25:07.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:109:0)
[10:25:07.689] Timer tick, asking Buildbucket for the build status
[10:25:07.750] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:07.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:110:0) after 1m0s
[10:26:07.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:110:0)
[10:26:07.797] Timer tick, asking Buildbucket for the build status
[10:26:07.899] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:07.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:111:0) after 1m0s
[10:27:07.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:111:0)
[10:27:07.898] Timer tick, asking Buildbucket for the build status
[10:27:08.213] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:08.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:112:0) after 1m0s
[10:28:08.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:112:0)
[10:28:08.254] Timer tick, asking Buildbucket for the build status
[10:28:08.441] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:08.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:113:0) after 1m0s
[10:29:08.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:113:0)
[10:29:08.526] Timer tick, asking Buildbucket for the build status
[10:29:08.852] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:08.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:114:0) after 1m0s
[10:30:08.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:114:0)
[10:30:08.929] Timer tick, asking Buildbucket for the build status
[10:30:09.103] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:09.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:115:0) after 1m0s
[10:31:09.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:115:0)
[10:31:09.151] Timer tick, asking Buildbucket for the build status
[10:31:09.263] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:09.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:116:0) after 1m0s
[10:32:09.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:116:0)
[10:32:09.442] Timer tick, asking Buildbucket for the build status
[10:32:09.540] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:09.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:117:0) after 1m0s
[10:33:09.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:117:0)
[10:33:09.513] Timer tick, asking Buildbucket for the build status
[10:33:09.627] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:09.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:118:0) after 1m0s
[10:34:09.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:118:0)
[10:34:09.698] Timer tick, asking Buildbucket for the build status
[10:34:09.841] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:09.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:119:0) after 1m0s
[10:35:09.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:119:0)
[10:35:09.896] Timer tick, asking Buildbucket for the build status
[10:35:10.323] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:10.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:120:0) after 1m0s
[10:36:10.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:120:0)
[10:36:10.440] Timer tick, asking Buildbucket for the build status
[10:36:10.521] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:10.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:121:0) after 1m0s
[10:37:10.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:121:0)
[10:37:10.536] Timer tick, asking Buildbucket for the build status
[10:37:10.641] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:10.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:122:0) after 1m0s
[10:38:10.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:122:0)
[10:38:10.701] Timer tick, asking Buildbucket for the build status
[10:38:10.928] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:10.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:123:0) after 1m0s
[10:39:12.030] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:123:0)
[10:39:12.030] Timer tick, asking Buildbucket for the build status
[10:39:12.102] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:12.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:124:0) after 1m0s
[10:40:12.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:124:0)
[10:40:12.157] Timer tick, asking Buildbucket for the build status
[10:40:12.317] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:12.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:125:0) after 1m0s
[10:41:12.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:125:0)
[10:41:12.341] Timer tick, asking Buildbucket for the build status
[10:41:12.411] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:12.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:126:0) after 1m0s
[10:42:12.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:126:0)
[10:42:12.521] Timer tick, asking Buildbucket for the build status
[10:42:12.609] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:12.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:127:0) after 1m0s
[10:43:12.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:127:0)
[10:43:12.623] Timer tick, asking Buildbucket for the build status
[10:43:12.713] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:12.713] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:128:0) after 1m0s
[10:44:12.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:128:0)
[10:44:12.813] Timer tick, asking Buildbucket for the build status
[10:44:12.968] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:12.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:129:0) after 1m0s
[10:45:13.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:129:0)
[10:45:13.389] Timer tick, asking Buildbucket for the build status
[10:45:13.457] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:13.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:130:0) after 1m0s
[10:46:13.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:130:0)
[10:46:13.629] Timer tick, asking Buildbucket for the build status
[10:46:13.701] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:13.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:131:0) after 1m0s
[10:47:13.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:131:0)
[10:47:13.914] Timer tick, asking Buildbucket for the build status
[10:47:13.981] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:13.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:132:0) after 1m0s
[10:48:14.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:132:0)
[10:48:14.106] Timer tick, asking Buildbucket for the build status
[10:48:14.239] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:14.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:133:0) after 1m0s
[10:49:14.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:133:0)
[10:49:14.281] Timer tick, asking Buildbucket for the build status
[10:49:14.443] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:14.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:134:0) after 1m0s
[10:50:14.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:134:0)
[10:50:14.507] Timer tick, asking Buildbucket for the build status
[10:50:14.580] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:14.580] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:135:0) after 1m0s
[10:51:14.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:135:0)
[10:51:14.602] Timer tick, asking Buildbucket for the build status
[10:51:14.686] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:14.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:136:0) after 1m0s
[10:52:14.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:136:0)
[10:52:14.745] Timer tick, asking Buildbucket for the build status
[10:52:15.169] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:15.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:137:0) after 1m0s
[10:53:15.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:137:0)
[10:53:15.150] Timer tick, asking Buildbucket for the build status
[10:53:15.344] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:15.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:138:0) after 1m0s
[10:54:15.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:138:0)
[10:54:15.370] Timer tick, asking Buildbucket for the build status
[10:54:15.539] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:15.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:139:0) after 1m0s
[10:55:15.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:139:0)
[10:55:15.549] Timer tick, asking Buildbucket for the build status
[10:55:15.614] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:15.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:140:0) after 1m0s
[10:56:15.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:140:0)
[10:56:15.645] Timer tick, asking Buildbucket for the build status
[10:56:15.715] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:15.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:141:0) after 1m0s
[10:57:15.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:141:0)
[10:57:15.783] Timer tick, asking Buildbucket for the build status
[10:57:15.864] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:15.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:142:0) after 1m0s
[10:58:15.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:142:0)
[10:58:15.845] Timer tick, asking Buildbucket for the build status
[10:58:15.929] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:15.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:143:0) after 1m0s
[10:59:15.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:143:0)
[10:59:15.977] Timer tick, asking Buildbucket for the build status
[10:59:16.107] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:16.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:144:0) after 1m0s
[11:00:16.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:144:0)
[11:00:16.203] Timer tick, asking Buildbucket for the build status
[11:00:16.283] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:16.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:145:0) after 1m0s
[11:01:16.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:145:0)
[11:01:16.331] Timer tick, asking Buildbucket for the build status
[11:01:16.430] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:16.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:146:0) after 1m0s
[11:02:16.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:146:0)
[11:02:16.513] Timer tick, asking Buildbucket for the build status
[11:02:16.596] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:16.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:147:0) after 1m0s
[11:03:16.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:147:0)
[11:03:16.660] Timer tick, asking Buildbucket for the build status
[11:03:16.765] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:16.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:148:0) after 1m0s
[11:04:16.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:148:0)
[11:04:16.785] Timer tick, asking Buildbucket for the build status
[11:04:16.878] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:16.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:149:0) after 1m0s
[11:05:16.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:149:0)
[11:05:16.893] Timer tick, asking Buildbucket for the build status
[11:05:16.967] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:16.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:150:0) after 1m0s
[11:06:17.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:150:0)
[11:06:17.005] Timer tick, asking Buildbucket for the build status
[11:06:17.073] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:17.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:151:0) after 1m0s
[11:07:17.140] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:151:0)
[11:07:17.140] Timer tick, asking Buildbucket for the build status
[11:07:17.589] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:17.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:152:0) after 1m0s
[11:08:17.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:152:0)
[11:08:17.659] Timer tick, asking Buildbucket for the build status
[11:08:17.760] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:17.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:153:0) after 1m0s
[11:09:17.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:153:0)
[11:09:17.761] Timer tick, asking Buildbucket for the build status
[11:09:17.828] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:17.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:154:0) after 1m0s
[11:10:17.911] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:154:0)
[11:10:17.911] Timer tick, asking Buildbucket for the build status
[11:10:17.996] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:17.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:155:0) after 1m0s
[11:11:18.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:155:0)
[11:11:18.049] Timer tick, asking Buildbucket for the build status
[11:11:18.147] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:18.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:156:0) after 1m0s
[11:12:18.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:156:0)
[11:12:18.256] Timer tick, asking Buildbucket for the build status
[11:12:18.330] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:18.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:157:0) after 1m0s
[11:13:18.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:157:0)
[11:13:18.330] Timer tick, asking Buildbucket for the build status
[11:13:18.429] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:18.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:158:0) after 1m0s
[11:14:18.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:158:0)
[11:14:18.457] Timer tick, asking Buildbucket for the build status
[11:14:18.632] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:18.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:159:0) after 1m0s
[11:15:18.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:159:0)
[11:15:18.690] Timer tick, asking Buildbucket for the build status
[11:15:18.930] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:18.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:160:0) after 1m0s
[11:16:18.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:160:0)
[11:16:18.963] Timer tick, asking Buildbucket for the build status
[11:16:19.036] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:19.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:161:0) after 1m0s
[11:17:19.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:161:0)
[11:17:19.324] Timer tick, asking Buildbucket for the build status
[11:17:19.403] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:19.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:162:0) after 1m0s
[11:18:19.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:162:0)
[11:18:19.661] Timer tick, asking Buildbucket for the build status
[11:18:19.966] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:19.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:163:0) after 1m0s
[11:19:19.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:163:0)
[11:19:19.980] Timer tick, asking Buildbucket for the build status
[11:19:20.133] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:20.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:164:0) after 1m0s
[11:20:20.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:164:0)
[11:20:20.184] Timer tick, asking Buildbucket for the build status
[11:20:20.435] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:20.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:165:0) after 1m0s
[11:21:20.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:165:0)
[11:21:20.559] Timer tick, asking Buildbucket for the build status
[11:21:20.693] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:20.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:166:0) after 1m0s
[11:22:20.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:166:0)
[11:22:20.809] Timer tick, asking Buildbucket for the build status
[11:22:21.011] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:21.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:167:0) after 1m0s
[11:23:21.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:167:0)
[11:23:21.159] Timer tick, asking Buildbucket for the build status
[11:23:21.265] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:21.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:168:0) after 1m0s
[11:24:21.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:168:0)
[11:24:21.282] Timer tick, asking Buildbucket for the build status
[11:24:21.418] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:21.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:169:0) after 1m0s
[11:25:21.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:169:0)
[11:25:21.498] Timer tick, asking Buildbucket for the build status
[11:25:21.615] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:21.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:170:0) after 1m0s
[11:26:21.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:170:0)
[11:26:21.687] Timer tick, asking Buildbucket for the build status
[11:26:21.778] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:21.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:171:0) after 1m0s
[11:27:21.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:171:0)
[11:27:21.804] Timer tick, asking Buildbucket for the build status
[11:27:21.879] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:21.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:172:0) after 1m0s
[11:28:21.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:172:0)
[11:28:21.968] Timer tick, asking Buildbucket for the build status
[11:28:22.065] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:22.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:173:0) after 1m0s
[11:29:22.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:173:0)
[11:29:22.139] Timer tick, asking Buildbucket for the build status
[11:29:22.246] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:22.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:174:0) after 1m0s
[11:30:22.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:174:0)
[11:30:22.290] Timer tick, asking Buildbucket for the build status
[11:30:22.604] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:22.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:175:0) after 1m0s
[11:31:22.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:175:0)
[11:31:22.786] Timer tick, asking Buildbucket for the build status
[11:31:22.875] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:22.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:176:0) after 1m0s
[11:32:22.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:176:0)
[11:32:22.929] Timer tick, asking Buildbucket for the build status
[11:32:23.022] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:23.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:177:0) after 1m0s
[11:33:23.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:177:0)
[11:33:23.039] Timer tick, asking Buildbucket for the build status
[11:33:23.409] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:23.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:178:0) after 1m0s
[11:34:23.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:178:0)
[11:34:23.587] Timer tick, asking Buildbucket for the build status
[11:34:23.749] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:23.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:179:0) after 1m0s
[11:35:23.772] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:179:0)
[11:35:23.772] Timer tick, asking Buildbucket for the build status
[11:35:23.936] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:23.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:180:0) after 1m0s
[11:36:24.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:180:0)
[11:36:24.026] Timer tick, asking Buildbucket for the build status
[11:36:24.161] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:24.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:181:0) after 1m0s
[11:37:24.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:181:0)
[11:37:24.195] Timer tick, asking Buildbucket for the build status
[11:37:24.268] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:24.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:182:0) after 1m0s
[11:38:24.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:182:0)
[11:38:24.298] Timer tick, asking Buildbucket for the build status
[11:38:24.692] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:24.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:183:0) after 1m0s
[11:39:24.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:183:0)
[11:39:24.702] Timer tick, asking Buildbucket for the build status
[11:39:24.950] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:24.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:184:0) after 1m0s
[11:40:24.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:184:0)
[11:40:24.986] Timer tick, asking Buildbucket for the build status
[11:40:25.065] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:25.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:185:0) after 1m0s
[11:41:25.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:185:0)
[11:41:25.060] Timer tick, asking Buildbucket for the build status
[11:41:25.137] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:25.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:186:0) after 1m0s
[11:42:25.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:186:0)
[11:42:25.212] Timer tick, asking Buildbucket for the build status
[11:42:25.295] Build 8854972198398646576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:25.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9020402260526436080:187:0) after 1m0s
[11:42:39.223] Received PubSub notification, asking Buildbucket for the build status
[11:42:39.318] Build 8854972198398646576: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:42:39.318] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1613648559013138",
    "created_by": "project:infra",
    "created_ts": "1613637464103361",
    "id": "8854972198398646576",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4324.186\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"9d137493-ab84-4ee6-894e-f7d32c4e6a88\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4324.186\"}}",
    "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-01ue\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5700-b36f18b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1613637489854349",
    "status": "COMPLETED",
    "status_changed_ts": "1613637490439200",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9020402260526436080",
      "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/8854972198398646576/+/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:51cd1b3a877b0410",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1613648559051517",
    "url": "https://ci.chromium.org/b/8854972198398646576",
    "utcnow_ts": "1613648559301570"
  }
}
[11:42:39.318] Invocation finished in 3h4m56.626502903s with status SUCCEEDED