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

• parent_buildername:publish_tarball
• user_agent:recipe

[09:28:35.271] New invocation is queued and will start shortly
[09:28:35.271] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[09:28:36.358] Starting the invocation (attempt 1)
[09:28:36.404] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:28:36.404] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:28:36.405] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9029821144189122816",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4314.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"d05fcc29-3b5a-42d6-951b-b48ab4a5e20c\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4314.2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9029821144189122816",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[09:28:36.919] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1604654916506248",
    "id": "8864391082228023920",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4314.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d05fcc29-3b5a-42d6-951b-b48ab4a5e20c\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4314.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1604654916701960",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9029821144189122816",
      "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/8864391082228023920/+/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": "1604654916702103",
    "url": "https://ci.chromium.org/b/8864391082228023920",
    "utcnow_ts": "1604654916905119"
  }
}
[09:28:36.919] Task URL: https://ci.chromium.org/b/8864391082228023920
[09:28:36.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:2:0) after 1m0s
[09:29:37.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:2:0)
[09:29:37.076] Timer tick, asking Buildbucket for the build status
[09:29:37.184] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:29:37.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:3:0) after 1m0s
[09:30:37.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:3:0)
[09:30:37.255] Timer tick, asking Buildbucket for the build status
[09:30:37.334] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:30:37.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:4:0) after 1m0s
[09:31:37.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:4:0)
[09:31:37.427] Timer tick, asking Buildbucket for the build status
[09:31:37.522] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:31:37.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:5:0) after 1m0s
[09:32:37.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:5:0)
[09:32:37.698] Timer tick, asking Buildbucket for the build status
[09:32:37.840] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:32:37.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:6:0) after 1m0s
[09:33:37.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:6:0)
[09:33:37.898] Timer tick, asking Buildbucket for the build status
[09:33:38.405] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:33:38.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:7:0) after 1m0s
[09:34:38.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:7:0)
[09:34:38.486] Timer tick, asking Buildbucket for the build status
[09:34:39.056] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:34:39.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:8:0) after 1m0s
[09:35:39.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:8:0)
[09:35:39.225] Timer tick, asking Buildbucket for the build status
[09:35:39.310] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:35:39.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:9:0) after 1m0s
[09:36:39.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:9:0)
[09:36:39.544] Timer tick, asking Buildbucket for the build status
[09:36:39.636] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:36:39.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:10:0) after 1m0s
[09:37:39.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:10:0)
[09:37:39.706] Timer tick, asking Buildbucket for the build status
[09:37:39.938] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:37:39.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:11:0) after 1m0s
[09:38:39.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:11:0)
[09:38:39.990] Timer tick, asking Buildbucket for the build status
[09:38:40.113] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:38:40.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:12:0) after 1m0s
[09:39:40.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:12:0)
[09:39:40.217] Timer tick, asking Buildbucket for the build status
[09:39:40.376] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:39:40.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:13:0) after 1m0s
[09:40:40.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:13:0)
[09:40:40.414] Timer tick, asking Buildbucket for the build status
[09:40:40.502] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:40:40.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:14:0) after 1m0s
[09:41:40.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:14:0)
[09:41:40.600] Timer tick, asking Buildbucket for the build status
[09:41:40.897] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:41:40.898] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:15:0) after 1m0s
[09:42:40.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:15:0)
[09:42:40.999] Timer tick, asking Buildbucket for the build status
[09:42:41.085] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:42:41.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:16:0) after 1m0s
[09:43:41.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:16:0)
[09:43:41.190] Timer tick, asking Buildbucket for the build status
[09:43:41.646] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:41.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:17:0) after 1m0s
[09:44:41.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:17:0)
[09:44:41.778] Timer tick, asking Buildbucket for the build status
[09:44:42.145] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:44:42.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:18:0) after 1m0s
[09:45:42.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:18:0)
[09:45:42.120] Timer tick, asking Buildbucket for the build status
[09:45:43.229] Build 8864391082228023920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:45:43.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:19:0) after 1m0s
[09:46:07.378] Received PubSub notification, asking Buildbucket for the build status
[09:46:07.459] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:43.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:19:0)
[09:46:43.325] Timer tick, asking Buildbucket for the build status
[09:46:44.236] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:44.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:21:0) after 1m0s
[09:47:44.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:21:0)
[09:47:44.292] Timer tick, asking Buildbucket for the build status
[09:47:44.502] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:44.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:22:0) after 1m0s
[09:48:44.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:22:0)
[09:48:44.513] Timer tick, asking Buildbucket for the build status
[09:48:44.635] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:44.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:23:0) after 1m0s
[09:49:44.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:23:0)
[09:49:44.690] Timer tick, asking Buildbucket for the build status
[09:49:44.753] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:44.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:24:0) after 1m0s
[09:50:44.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:24:0)
[09:50:44.848] Timer tick, asking Buildbucket for the build status
[09:50:44.978] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:44.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:25:0) after 1m0s
[09:51:45.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:25:0)
[09:51:45.039] Timer tick, asking Buildbucket for the build status
[09:51:45.105] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:45.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:26:0) after 1m0s
[09:52:45.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:26:0)
[09:52:45.165] Timer tick, asking Buildbucket for the build status
[09:52:45.226] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:45.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:27:0) after 1m0s
[09:53:45.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:27:0)
[09:53:45.393] Timer tick, asking Buildbucket for the build status
[09:53:45.830] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:45.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:28:0) after 1m0s
[09:54:45.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:28:0)
[09:54:45.955] Timer tick, asking Buildbucket for the build status
[09:54:46.026] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:46.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:29:0) after 1m0s
[09:55:46.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:29:0)
[09:55:46.031] Timer tick, asking Buildbucket for the build status
[09:55:46.111] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:46.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:30:0) after 1m0s
[09:56:46.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:30:0)
[09:56:46.148] Timer tick, asking Buildbucket for the build status
[09:56:46.222] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:46.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:31:0) after 1m0s
[09:57:46.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:31:0)
[09:57:46.251] Timer tick, asking Buildbucket for the build status
[09:57:46.335] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:46.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:32:0) after 1m0s
[09:58:46.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:32:0)
[09:58:46.455] Timer tick, asking Buildbucket for the build status
[09:58:46.565] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:46.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:33:0) after 1m0s
[09:59:46.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:33:0)
[09:59:46.591] Timer tick, asking Buildbucket for the build status
[09:59:46.674] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:46.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:34:0) after 1m0s
[10:00:47.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:34:0)
[10:00:47.039] Timer tick, asking Buildbucket for the build status
[10:00:47.125] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:47.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:35:0) after 1m0s
[10:01:47.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:35:0)
[10:01:47.441] Timer tick, asking Buildbucket for the build status
[10:01:47.640] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:47.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:36:0) after 1m0s
[10:02:47.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:36:0)
[10:02:47.913] Timer tick, asking Buildbucket for the build status
[10:02:48.116] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:48.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:37:0) after 1m0s
[10:03:48.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:37:0)
[10:03:48.312] Timer tick, asking Buildbucket for the build status
[10:03:48.442] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:48.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:38:0) after 1m0s
[10:04:48.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:38:0)
[10:04:48.711] Timer tick, asking Buildbucket for the build status
[10:04:48.777] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:48.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:39:0) after 1m0s
[10:05:48.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:39:0)
[10:05:48.983] Timer tick, asking Buildbucket for the build status
[10:05:49.068] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:49.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:40:0) after 1m0s
[10:06:49.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:40:0)
[10:06:49.147] Timer tick, asking Buildbucket for the build status
[10:06:49.215] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:49.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:41:0) after 1m0s
[10:07:49.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:41:0)
[10:07:49.281] Timer tick, asking Buildbucket for the build status
[10:07:49.428] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:49.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:42:0) after 1m0s
[10:08:49.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:42:0)
[10:08:49.543] Timer tick, asking Buildbucket for the build status
[10:08:49.655] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:49.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:43:0) after 1m0s
[10:09:49.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:43:0)
[10:09:49.737] Timer tick, asking Buildbucket for the build status
[10:09:50.130] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:50.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:44:0) after 1m0s
[10:10:50.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:44:0)
[10:10:50.217] Timer tick, asking Buildbucket for the build status
[10:10:50.356] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:50.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:45:0) after 1m0s
[10:11:50.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:45:0)
[10:11:50.391] Timer tick, asking Buildbucket for the build status
[10:11:50.466] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:50.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:46:0) after 1m0s
[10:12:50.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:46:0)
[10:12:50.537] Timer tick, asking Buildbucket for the build status
[10:12:50.711] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:50.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:47:0) after 1m0s
[10:13:50.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:47:0)
[10:13:50.733] Timer tick, asking Buildbucket for the build status
[10:13:51.185] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:51.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:48:0) after 1m0s
[10:14:51.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:48:0)
[10:14:51.272] Timer tick, asking Buildbucket for the build status
[10:14:51.341] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:51.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:49:0) after 1m0s
[10:15:51.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:49:0)
[10:15:51.362] Timer tick, asking Buildbucket for the build status
[10:15:52.014] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:52.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:50:0) after 1m0s
[10:16:52.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:50:0)
[10:16:52.061] Timer tick, asking Buildbucket for the build status
[10:16:52.133] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:52.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:51:0) after 1m0s
[10:17:52.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:51:0)
[10:17:52.146] Timer tick, asking Buildbucket for the build status
[10:17:52.208] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:52.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:52:0) after 1m0s
[10:18:52.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:52:0)
[10:18:52.274] Timer tick, asking Buildbucket for the build status
[10:18:52.433] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:52.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:53:0) after 1m0s
[10:19:52.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:53:0)
[10:19:52.465] Timer tick, asking Buildbucket for the build status
[10:19:52.525] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:52.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:54:0) after 1m0s
[10:20:52.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:54:0)
[10:20:52.557] Timer tick, asking Buildbucket for the build status
[10:20:52.623] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:52.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:55:0) after 1m0s
[10:21:52.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:55:0)
[10:21:52.650] Timer tick, asking Buildbucket for the build status
[10:21:52.940] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:52.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:56:0) after 1m0s
[10:22:53.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:56:0)
[10:22:53.572] Timer tick, asking Buildbucket for the build status
[10:22:53.629] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:53.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:57:0) after 1m0s
[10:23:53.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:57:0)
[10:23:53.810] Timer tick, asking Buildbucket for the build status
[10:23:53.911] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:53.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:58:0) after 1m0s
[10:24:54.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:58:0)
[10:24:54.024] Timer tick, asking Buildbucket for the build status
[10:24:54.111] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:54.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:59:0) after 1m0s
[10:25:54.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:59:0)
[10:25:54.142] Timer tick, asking Buildbucket for the build status
[10:25:54.243] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:54.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:60:0) after 1m0s
[10:26:54.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:60:0)
[10:26:54.292] Timer tick, asking Buildbucket for the build status
[10:26:54.397] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:54.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:61:0) after 1m0s
[10:27:54.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:61:0)
[10:27:54.420] Timer tick, asking Buildbucket for the build status
[10:27:54.628] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:54.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:62:0) after 1m0s
[10:28:54.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:62:0)
[10:28:54.652] Timer tick, asking Buildbucket for the build status
[10:28:54.751] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:54.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:63:0) after 1m0s
[10:29:54.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:63:0)
[10:29:54.810] Timer tick, asking Buildbucket for the build status
[10:29:54.886] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:54.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:64:0) after 1m0s
[10:30:54.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:64:0)
[10:30:54.914] Timer tick, asking Buildbucket for the build status
[10:30:55.129] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:55.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:65:0) after 1m0s
[10:31:55.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:65:0)
[10:31:55.199] Timer tick, asking Buildbucket for the build status
[10:31:55.477] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:55.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:66:0) after 1m0s
[10:32:55.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:66:0)
[10:32:55.518] Timer tick, asking Buildbucket for the build status
[10:32:55.589] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:55.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:67:0) after 1m0s
[10:33:55.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:67:0)
[10:33:55.652] Timer tick, asking Buildbucket for the build status
[10:33:55.828] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:55.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:68:0) after 1m0s
[10:34:55.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:68:0)
[10:34:55.961] Timer tick, asking Buildbucket for the build status
[10:34:56.103] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:56.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:69:0) after 1m0s
[10:35:56.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:69:0)
[10:35:56.109] Timer tick, asking Buildbucket for the build status
[10:35:56.171] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:56.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:70:0) after 1m0s
[10:36:56.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:70:0)
[10:36:56.231] Timer tick, asking Buildbucket for the build status
[10:36:56.294] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:56.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:71:0) after 1m0s
[10:37:56.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:71:0)
[10:37:56.365] Timer tick, asking Buildbucket for the build status
[10:37:56.432] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:56.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:72:0) after 1m0s
[10:38:56.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:72:0)
[10:38:56.543] Timer tick, asking Buildbucket for the build status
[10:38:56.641] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:56.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:73:0) after 1m0s
[10:39:56.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:73:0)
[10:39:56.789] Timer tick, asking Buildbucket for the build status
[10:39:56.854] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:56.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:74:0) after 1m0s
[10:40:56.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:74:0)
[10:40:56.994] Timer tick, asking Buildbucket for the build status
[10:40:57.348] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:57.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:75:0) after 1m0s
[10:41:57.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:75:0)
[10:41:57.378] Timer tick, asking Buildbucket for the build status
[10:41:57.444] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:57.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:76:0) after 1m0s
[10:42:57.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:76:0)
[10:42:57.538] Timer tick, asking Buildbucket for the build status
[10:42:57.610] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:57.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:77:0) after 1m0s
[10:43:57.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:77:0)
[10:43:57.635] Timer tick, asking Buildbucket for the build status
[10:43:57.740] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:57.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:78:0) after 1m0s
[10:44:57.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:78:0)
[10:44:57.897] Timer tick, asking Buildbucket for the build status
[10:44:57.974] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:57.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:79:0) after 1m0s
[10:45:58.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:79:0)
[10:45:58.051] Timer tick, asking Buildbucket for the build status
[10:45:58.127] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:58.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:80:0) after 1m0s
[10:46:58.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:80:0)
[10:46:58.153] Timer tick, asking Buildbucket for the build status
[10:46:58.259] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:58.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:81:0) after 1m0s
[10:47:58.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:81:0)
[10:47:58.320] Timer tick, asking Buildbucket for the build status
[10:47:58.380] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:58.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:82:0) after 1m0s
[10:48:58.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:82:0)
[10:48:58.409] Timer tick, asking Buildbucket for the build status
[10:48:58.512] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:58.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:83:0) after 1m0s
[10:49:58.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:83:0)
[10:49:58.656] Timer tick, asking Buildbucket for the build status
[10:49:58.738] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:58.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:84:0) after 1m0s
[10:50:59.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:84:0)
[10:50:59.004] Timer tick, asking Buildbucket for the build status
[10:50:59.200] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:59.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:85:0) after 1m0s
[10:51:59.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:85:0)
[10:51:59.303] Timer tick, asking Buildbucket for the build status
[10:51:59.363] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:59.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:86:0) after 1m0s
[10:52:59.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:86:0)
[10:52:59.512] Timer tick, asking Buildbucket for the build status
[10:52:59.588] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:59.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:87:0) after 1m0s
[10:53:59.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:87:0)
[10:53:59.629] Timer tick, asking Buildbucket for the build status
[10:53:59.725] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:59.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:88:0) after 1m0s
[10:54:59.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:88:0)
[10:54:59.812] Timer tick, asking Buildbucket for the build status
[10:54:59.886] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:59.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:89:0) after 1m0s
[10:55:59.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:89:0)
[10:55:59.936] Timer tick, asking Buildbucket for the build status
[10:56:00.146] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:00.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:90:0) after 1m0s
[10:57:00.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:90:0)
[10:57:00.348] Timer tick, asking Buildbucket for the build status
[10:57:00.417] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:00.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:91:0) after 1m0s
[10:58:00.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:91:0)
[10:58:00.608] Timer tick, asking Buildbucket for the build status
[10:58:00.845] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:00.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:92:0) after 1m0s
[10:59:01.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:92:0)
[10:59:01.761] Timer tick, asking Buildbucket for the build status
[10:59:02.109] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:02.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:93:0) after 1m0s
[11:00:02.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:93:0)
[11:00:02.503] Timer tick, asking Buildbucket for the build status
[11:00:02.655] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:02.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:94:0) after 1m0s
[11:01:02.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:94:0)
[11:01:02.774] Timer tick, asking Buildbucket for the build status
[11:01:02.847] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:02.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:95:0) after 1m0s
[11:02:02.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:95:0)
[11:02:02.837] Timer tick, asking Buildbucket for the build status
[11:02:03.081] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:03.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:96:0) after 1m0s
[11:03:03.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:96:0)
[11:03:03.148] Timer tick, asking Buildbucket for the build status
[11:03:03.237] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:03.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:97:0) after 1m0s
[11:04:03.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:97:0)
[11:04:03.878] Timer tick, asking Buildbucket for the build status
[11:04:04.031] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:04.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:98:0) after 1m0s
[11:05:04.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:98:0)
[11:05:04.137] Timer tick, asking Buildbucket for the build status
[11:05:04.257] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:04.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:99:0) after 1m0s
[11:06:04.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:99:0)
[11:06:04.273] Timer tick, asking Buildbucket for the build status
[11:06:04.844] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:04.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:100:0) after 1m0s
[11:07:04.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:100:0)
[11:07:04.914] Timer tick, asking Buildbucket for the build status
[11:07:05.165] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:05.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:101:0) after 1m0s
[11:08:05.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:101:0)
[11:08:05.275] Timer tick, asking Buildbucket for the build status
[11:08:05.353] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:05.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:102:0) after 1m0s
[11:09:05.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:102:0)
[11:09:05.431] Timer tick, asking Buildbucket for the build status
[11:09:05.545] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:05.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:103:0) after 1m0s
[11:10:05.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:103:0)
[11:10:05.711] Timer tick, asking Buildbucket for the build status
[11:10:05.777] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:05.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:104:0) after 1m0s
[11:11:05.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:104:0)
[11:11:05.884] Timer tick, asking Buildbucket for the build status
[11:11:05.949] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:05.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:105:0) after 1m0s
[11:12:05.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:105:0)
[11:12:05.978] Timer tick, asking Buildbucket for the build status
[11:12:06.044] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:06.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:106:0) after 1m0s
[11:13:06.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:106:0)
[11:13:06.183] Timer tick, asking Buildbucket for the build status
[11:13:06.449] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:06.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:107:0) after 1m0s
[11:14:06.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:107:0)
[11:14:06.505] Timer tick, asking Buildbucket for the build status
[11:14:06.626] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:06.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:108:0) after 1m0s
[11:15:06.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:108:0)
[11:15:06.660] Timer tick, asking Buildbucket for the build status
[11:15:06.775] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:06.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:109:0) after 1m0s
[11:16:06.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:109:0)
[11:16:06.901] Timer tick, asking Buildbucket for the build status
[11:16:07.025] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:07.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:110:0) after 1m0s
[11:17:07.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:110:0)
[11:17:07.149] Timer tick, asking Buildbucket for the build status
[11:17:07.219] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:07.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:111:0) after 1m0s
[11:18:07.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:111:0)
[11:18:07.258] Timer tick, asking Buildbucket for the build status
[11:18:07.329] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:07.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:112:0) after 1m0s
[11:19:07.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:112:0)
[11:19:07.390] Timer tick, asking Buildbucket for the build status
[11:19:07.494] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:07.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:113:0) after 1m0s
[11:20:07.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:113:0)
[11:20:07.489] Timer tick, asking Buildbucket for the build status
[11:20:07.625] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:07.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:114:0) after 1m0s
[11:21:07.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:114:0)
[11:21:07.664] Timer tick, asking Buildbucket for the build status
[11:21:07.722] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:07.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:115:0) after 1m0s
[11:22:07.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:115:0)
[11:22:07.758] Timer tick, asking Buildbucket for the build status
[11:22:07.878] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:07.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:116:0) after 1m0s
[11:23:08.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:116:0)
[11:23:08.072] Timer tick, asking Buildbucket for the build status
[11:23:08.143] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:08.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:117:0) after 1m0s
[11:24:08.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:117:0)
[11:24:08.202] Timer tick, asking Buildbucket for the build status
[11:24:08.314] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:08.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:118:0) after 1m0s
[11:25:08.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:118:0)
[11:25:08.403] Timer tick, asking Buildbucket for the build status
[11:25:08.480] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:08.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:119:0) after 1m0s
[11:26:08.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:119:0)
[11:26:08.497] Timer tick, asking Buildbucket for the build status
[11:26:08.570] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:08.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:120:0) after 1m0s
[11:27:08.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:120:0)
[11:27:08.581] Timer tick, asking Buildbucket for the build status
[11:27:08.794] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:08.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:121:0) after 1m0s
[11:28:08.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:121:0)
[11:28:08.876] Timer tick, asking Buildbucket for the build status
[11:28:09.149] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:09.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:122:0) after 1m0s
[11:29:09.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:122:0)
[11:29:09.198] Timer tick, asking Buildbucket for the build status
[11:29:09.350] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:09.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:123:0) after 1m0s
[11:30:09.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:123:0)
[11:30:09.376] Timer tick, asking Buildbucket for the build status
[11:30:09.527] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:09.527] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:124:0) after 1m0s
[11:31:10.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:124:0)
[11:31:10.506] Timer tick, asking Buildbucket for the build status
[11:31:10.576] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:10.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:125:0) after 1m0s
[11:32:10.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:125:0)
[11:32:10.996] Timer tick, asking Buildbucket for the build status
[11:32:11.079] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:11.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:126:0) after 1m0s
[11:33:11.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:126:0)
[11:33:11.213] Timer tick, asking Buildbucket for the build status
[11:33:11.394] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:11.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:127:0) after 1m0s
[11:34:11.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:127:0)
[11:34:11.537] Timer tick, asking Buildbucket for the build status
[11:34:11.735] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:11.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:128:0) after 1m0s
[11:35:11.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:128:0)
[11:35:11.800] Timer tick, asking Buildbucket for the build status
[11:35:11.869] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:11.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:129:0) after 1m0s
[11:36:11.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:129:0)
[11:36:11.903] Timer tick, asking Buildbucket for the build status
[11:36:13.120] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:13.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:130:0) after 1m0s
[11:37:13.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:130:0)
[11:37:13.208] Timer tick, asking Buildbucket for the build status
[11:37:13.283] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:13.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:131:0) after 1m0s
[11:38:13.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:131:0)
[11:38:13.412] Timer tick, asking Buildbucket for the build status
[11:38:13.490] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:13.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:132:0) after 1m0s
[11:39:13.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:132:0)
[11:39:13.559] Timer tick, asking Buildbucket for the build status
[11:39:14.628] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:14.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:133:0) after 1m0s
[11:40:14.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:133:0)
[11:40:14.754] Timer tick, asking Buildbucket for the build status
[11:40:14.831] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:14.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:134:0) after 1m0s
[11:41:14.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:134:0)
[11:41:14.841] Timer tick, asking Buildbucket for the build status
[11:41:14.922] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:14.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:135:0) after 1m0s
[11:42:15.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:135:0)
[11:42:15.008] Timer tick, asking Buildbucket for the build status
[11:42:15.236] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:15.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:136:0) after 1m0s
[11:43:15.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:136:0)
[11:43:15.295] Timer tick, asking Buildbucket for the build status
[11:43:15.357] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:15.357] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:137:0) after 1m0s
[11:44:15.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:137:0)
[11:44:15.390] Timer tick, asking Buildbucket for the build status
[11:44:15.686] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:15.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:138:0) after 1m0s
[11:45:15.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:138:0)
[11:45:15.706] Timer tick, asking Buildbucket for the build status
[11:45:15.791] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:15.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:139:0) after 1m0s
[11:46:15.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:139:0)
[11:46:15.894] Timer tick, asking Buildbucket for the build status
[11:46:16.111] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:16.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:140:0) after 1m0s
[11:47:16.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:140:0)
[11:47:16.159] Timer tick, asking Buildbucket for the build status
[11:47:16.309] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:16.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:141:0) after 1m0s
[11:48:19.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:141:0)
[11:48:19.514] Timer tick, asking Buildbucket for the build status
[11:48:19.604] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:19.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:142:0) after 1m0s
[11:49:19.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:142:0)
[11:49:19.620] Timer tick, asking Buildbucket for the build status
[11:49:19.952] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:19.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:143:0) after 1m0s
[11:50:19.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:143:0)
[11:50:19.982] Timer tick, asking Buildbucket for the build status
[11:50:20.053] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:20.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:144:0) after 1m0s
[11:51:20.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:144:0)
[11:51:20.089] Timer tick, asking Buildbucket for the build status
[11:51:20.189] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:20.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:145:0) after 1m0s
[11:52:20.260] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:145:0)
[11:52:20.260] Timer tick, asking Buildbucket for the build status
[11:52:20.351] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:20.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:146:0) after 1m0s
[11:53:20.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:146:0)
[11:53:20.410] Timer tick, asking Buildbucket for the build status
[11:53:20.506] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:20.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:147:0) after 1m0s
[11:54:20.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:147:0)
[11:54:20.672] Timer tick, asking Buildbucket for the build status
[11:54:20.774] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:20.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:148:0) after 1m0s
[11:55:20.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:148:0)
[11:55:20.835] Timer tick, asking Buildbucket for the build status
[11:55:20.944] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:20.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:149:0) after 1m0s
[11:56:20.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:149:0)
[11:56:20.965] Timer tick, asking Buildbucket for the build status
[11:56:21.235] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:21.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:150:0) after 1m0s
[11:57:21.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:150:0)
[11:57:21.267] Timer tick, asking Buildbucket for the build status
[11:57:21.339] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:21.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:151:0) after 1m0s
[11:58:21.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:151:0)
[11:58:21.321] Timer tick, asking Buildbucket for the build status
[11:58:21.602] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:21.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:152:0) after 1m0s
[11:59:21.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:152:0)
[11:59:21.636] Timer tick, asking Buildbucket for the build status
[11:59:22.020] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:22.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:153:0) after 1m0s
[12:00:22.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:153:0)
[12:00:22.177] Timer tick, asking Buildbucket for the build status
[12:00:23.594] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:23.594] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:154:0) after 1m0s
[12:01:23.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:154:0)
[12:01:23.673] Timer tick, asking Buildbucket for the build status
[12:01:24.076] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:24.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:155:0) after 1m0s
[12:02:24.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:155:0)
[12:02:24.272] Timer tick, asking Buildbucket for the build status
[12:02:24.691] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:24.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:156:0) after 1m0s
[12:03:24.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:156:0)
[12:03:24.905] Timer tick, asking Buildbucket for the build status
[12:03:24.972] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:24.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:157:0) after 1m0s
[12:04:25.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:157:0)
[12:04:25.086] Timer tick, asking Buildbucket for the build status
[12:04:25.267] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:25.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:158:0) after 1m0s
[12:05:25.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:158:0)
[12:05:25.407] Timer tick, asking Buildbucket for the build status
[12:05:25.561] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:25.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:159:0) after 1m0s
[12:06:25.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:159:0)
[12:06:25.670] Timer tick, asking Buildbucket for the build status
[12:06:25.740] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:25.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:160:0) after 1m0s
[12:07:25.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:160:0)
[12:07:25.829] Timer tick, asking Buildbucket for the build status
[12:07:25.927] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:25.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:161:0) after 1m0s
[12:08:25.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:161:0)
[12:08:25.968] Timer tick, asking Buildbucket for the build status
[12:08:26.179] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:26.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:162:0) after 1m0s
[12:09:26.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:162:0)
[12:09:26.208] Timer tick, asking Buildbucket for the build status
[12:09:26.366] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:26.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:163:0) after 1m0s
[12:10:26.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:163:0)
[12:10:26.402] Timer tick, asking Buildbucket for the build status
[12:10:26.483] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:26.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:164:0) after 1m0s
[12:11:26.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:164:0)
[12:11:26.642] Timer tick, asking Buildbucket for the build status
[12:11:26.751] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:26.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:165:0) after 1m0s
[12:12:26.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:165:0)
[12:12:26.779] Timer tick, asking Buildbucket for the build status
[12:12:26.990] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:26.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:166:0) after 1m0s
[12:13:27.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:166:0)
[12:13:27.036] Timer tick, asking Buildbucket for the build status
[12:13:27.103] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:27.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:167:0) after 1m0s
[12:14:27.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:167:0)
[12:14:27.138] Timer tick, asking Buildbucket for the build status
[12:14:27.249] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:27.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:168:0) after 1m0s
[12:15:27.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:168:0)
[12:15:27.310] Timer tick, asking Buildbucket for the build status
[12:15:27.402] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:27.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:169:0) after 1m0s
[12:16:27.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:169:0)
[12:16:27.432] Timer tick, asking Buildbucket for the build status
[12:16:27.523] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:27.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:170:0) after 1m0s
[12:17:27.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:170:0)
[12:17:27.569] Timer tick, asking Buildbucket for the build status
[12:17:27.934] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:27.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:171:0) after 1m0s
[12:18:28.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:171:0)
[12:18:28.093] Timer tick, asking Buildbucket for the build status
[12:18:28.499] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:28.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:172:0) after 1m0s
[12:19:28.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:172:0)
[12:19:28.572] Timer tick, asking Buildbucket for the build status
[12:19:28.678] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:28.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:173:0) after 1m0s
[12:20:33.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:173:0)
[12:20:33.568] Timer tick, asking Buildbucket for the build status
[12:20:33.631] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:33.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:174:0) after 1m0s
[12:21:33.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:174:0)
[12:21:33.624] Timer tick, asking Buildbucket for the build status
[12:21:33.814] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:33.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:175:0) after 1m0s
[12:22:33.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:175:0)
[12:22:33.871] Timer tick, asking Buildbucket for the build status
[12:22:33.931] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:33.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:176:0) after 1m0s
[12:23:33.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:176:0)
[12:23:33.966] Timer tick, asking Buildbucket for the build status
[12:23:34.083] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:34.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:177:0) after 1m0s
[12:24:34.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:177:0)
[12:24:34.147] Timer tick, asking Buildbucket for the build status
[12:24:34.250] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:34.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:178:0) after 1m0s
[12:25:34.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:178:0)
[12:25:34.322] Timer tick, asking Buildbucket for the build status
[12:25:34.394] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:34.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:179:0) after 1m0s
[12:26:34.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:179:0)
[12:26:34.527] Timer tick, asking Buildbucket for the build status
[12:26:34.585] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:34.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:180:0) after 1m0s
[12:27:34.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:180:0)
[12:27:34.591] Timer tick, asking Buildbucket for the build status
[12:27:34.663] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:34.663] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:181:0) after 1m0s
[12:28:34.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:181:0)
[12:28:34.733] Timer tick, asking Buildbucket for the build status
[12:28:35.054] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:35.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:182:0) after 1m0s
[12:29:35.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:182:0)
[12:29:35.108] Timer tick, asking Buildbucket for the build status
[12:29:35.255] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:35.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:183:0) after 1m0s
[12:30:35.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:183:0)
[12:30:35.267] Timer tick, asking Buildbucket for the build status
[12:30:35.361] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:35.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:184:0) after 1m0s
[12:31:35.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:184:0)
[12:31:35.371] Timer tick, asking Buildbucket for the build status
[12:31:35.572] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:35.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:185:0) after 1m0s
[12:32:35.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:185:0)
[12:32:35.675] Timer tick, asking Buildbucket for the build status
[12:32:35.753] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:35.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:186:0) after 1m0s
[12:33:35.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:186:0)
[12:33:35.840] Timer tick, asking Buildbucket for the build status
[12:33:35.919] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:35.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:187:0) after 1m0s
[12:34:35.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:187:0)
[12:34:35.977] Timer tick, asking Buildbucket for the build status
[12:34:36.429] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:36.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:188:0) after 1m0s
[12:35:36.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:188:0)
[12:35:36.495] Timer tick, asking Buildbucket for the build status
[12:35:36.593] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:36.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:189:0) after 1m0s
[12:36:36.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:189:0)
[12:36:36.659] Timer tick, asking Buildbucket for the build status
[12:36:37.213] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:37.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:190:0) after 1m0s
[12:37:37.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:190:0)
[12:37:37.255] Timer tick, asking Buildbucket for the build status
[12:37:37.320] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:37.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:191:0) after 1m0s
[12:38:37.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:191:0)
[12:38:37.388] Timer tick, asking Buildbucket for the build status
[12:38:37.547] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:37.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:192:0) after 1m0s
[12:39:37.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:192:0)
[12:39:37.547] Timer tick, asking Buildbucket for the build status
[12:39:37.653] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:37.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:193:0) after 1m0s
[12:40:37.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:193:0)
[12:40:37.749] Timer tick, asking Buildbucket for the build status
[12:40:37.992] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:37.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:194:0) after 1m0s
[12:41:38.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:194:0)
[12:41:38.294] Timer tick, asking Buildbucket for the build status
[12:41:38.356] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:38.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:195:0) after 1m0s
[12:42:38.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:195:0)
[12:42:38.435] Timer tick, asking Buildbucket for the build status
[12:42:38.507] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:38.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:196:0) after 1m0s
[12:43:38.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:196:0)
[12:43:38.637] Timer tick, asking Buildbucket for the build status
[12:43:38.747] Build 8864391082228023920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:38.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9029821144189122816:197:0) after 1m0s
[12:43:58.674] Received PubSub notification, asking Buildbucket for the build status
[12:43:58.740] Build 8864391082228023920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:43:58.740] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1604666637188612",
    "created_by": "project:infra",
    "created_ts": "1604654916506248",
    "id": "8864391082228023920",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4314.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d05fcc29-3b5a-42d6-951b-b48ab4a5e20c\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4314.2\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_292036ca8cd0711903e829a3c5417e821d204af08fdef2e4b6d3affbee40eeb2_v2\", \"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-ncb0\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1604655965242815",
    "status": "COMPLETED",
    "status_changed_ts": "1604666637668788",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9029821144189122816",
      "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/8864391082228023920/+/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:4fb5b46ec31c1910",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1604666637832809",
    "url": "https://ci.chromium.org/b/8864391082228023920",
    "utcnow_ts": "1604666638732434"
  }
}
[12:43:58.740] Invocation finished in 3h15m23.488181114s with status SUCCEEDED