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

• parent_buildername:publish_tarball
• user_agent:recipe

[06:22:36.494] New invocation is queued and will start shortly
[06:22:36.494] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[06:22:37.755] Starting the invocation (attempt 1)
[06:22:37.800] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:22:37.800] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:22:37.800] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9028202099618295728",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4240.199\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"010ddabe-bf6b-4029-a1be-66dee280ca48\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4240.199\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9028202099618295728",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[06:22:38.234] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1606198957915367",
    "id": "8862772037463784720",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.199\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"010ddabe-bf6b-4029-a1be-66dee280ca48\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.199\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1606198958125631",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9028202099618295728",
      "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/8862772037463784720/+/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": "1606198958125743",
    "url": "https://ci.chromium.org/b/8862772037463784720",
    "utcnow_ts": "1606198958225149"
  }
}
[06:22:38.234] Task URL: https://ci.chromium.org/b/8862772037463784720
[06:22:38.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:2:0) after 1m0s
[06:22:57.158] Received PubSub notification, asking Buildbucket for the build status
[06:22:57.233] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:38.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:2:0)
[06:23:38.225] Timer tick, asking Buildbucket for the build status
[06:23:38.313] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:38.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:4:0) after 1m0s
[06:24:38.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:4:0)
[06:24:38.339] Timer tick, asking Buildbucket for the build status
[06:24:38.398] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:38.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:5:0) after 1m0s
[06:25:38.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:5:0)
[06:25:38.455] Timer tick, asking Buildbucket for the build status
[06:25:38.569] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:38.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:6:0) after 1m0s
[06:26:38.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:6:0)
[06:26:38.567] Timer tick, asking Buildbucket for the build status
[06:26:38.632] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:38.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:7:0) after 1m0s
[06:27:38.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:7:0)
[06:27:38.623] Timer tick, asking Buildbucket for the build status
[06:27:38.686] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:38.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:8:0) after 1m0s
[06:28:38.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:8:0)
[06:28:38.751] Timer tick, asking Buildbucket for the build status
[06:28:39.064] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:39.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:9:0) after 1m0s
[06:29:39.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:9:0)
[06:29:39.114] Timer tick, asking Buildbucket for the build status
[06:29:39.187] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:39.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:10:0) after 1m0s
[06:30:39.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:10:0)
[06:30:39.206] Timer tick, asking Buildbucket for the build status
[06:30:39.321] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:39.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:11:0) after 1m0s
[06:31:39.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:11:0)
[06:31:39.342] Timer tick, asking Buildbucket for the build status
[06:31:39.521] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:39.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:12:0) after 1m0s
[06:32:39.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:12:0)
[06:32:39.585] Timer tick, asking Buildbucket for the build status
[06:32:40.177] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:40.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:13:0) after 1m0s
[06:33:40.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:13:0)
[06:33:40.211] Timer tick, asking Buildbucket for the build status
[06:33:40.289] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:40.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:14:0) after 1m0s
[06:34:40.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:14:0)
[06:34:40.275] Timer tick, asking Buildbucket for the build status
[06:34:40.675] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:40.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:15:0) after 1m0s
[06:35:40.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:15:0)
[06:35:40.700] Timer tick, asking Buildbucket for the build status
[06:35:40.785] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:40.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:16:0) after 1m0s
[06:36:40.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:16:0)
[06:36:40.881] Timer tick, asking Buildbucket for the build status
[06:36:41.046] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:41.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:17:0) after 1m0s
[06:37:41.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:17:0)
[06:37:41.074] Timer tick, asking Buildbucket for the build status
[06:37:41.196] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:41.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:18:0) after 1m0s
[06:38:41.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:18:0)
[06:38:41.251] Timer tick, asking Buildbucket for the build status
[06:38:41.342] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:41.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:19:0) after 1m0s
[06:39:41.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:19:0)
[06:39:41.376] Timer tick, asking Buildbucket for the build status
[06:39:41.451] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:41.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:20:0) after 1m0s
[06:40:41.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:20:0)
[06:40:41.496] Timer tick, asking Buildbucket for the build status
[06:40:41.561] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:41.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:21:0) after 1m0s
[06:41:41.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:21:0)
[06:41:41.580] Timer tick, asking Buildbucket for the build status
[06:41:41.740] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:41.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:22:0) after 1m0s
[06:42:41.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:22:0)
[06:42:41.729] Timer tick, asking Buildbucket for the build status
[06:42:41.843] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:41.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:23:0) after 1m0s
[06:43:41.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:23:0)
[06:43:41.931] Timer tick, asking Buildbucket for the build status
[06:43:43.257] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:43.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:24:0) after 1m0s
[06:44:43.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:24:0)
[06:44:43.381] Timer tick, asking Buildbucket for the build status
[06:44:43.930] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:43.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:25:0) after 1m0s
[06:45:44.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:25:0)
[06:45:44.063] Timer tick, asking Buildbucket for the build status
[06:45:44.142] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:44.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:26:0) after 1m0s
[06:46:44.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:26:0)
[06:46:44.144] Timer tick, asking Buildbucket for the build status
[06:46:44.335] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:44.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:27:0) after 1m0s
[06:47:44.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:27:0)
[06:47:44.438] Timer tick, asking Buildbucket for the build status
[06:47:44.566] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:44.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:28:0) after 1m0s
[06:48:44.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:28:0)
[06:48:44.727] Timer tick, asking Buildbucket for the build status
[06:48:44.787] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:44.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:29:0) after 1m0s
[06:49:44.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:29:0)
[06:49:44.774] Timer tick, asking Buildbucket for the build status
[06:49:44.830] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:44.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:30:0) after 1m0s
[06:50:44.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:30:0)
[06:50:44.896] Timer tick, asking Buildbucket for the build status
[06:50:45.036] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:45.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:31:0) after 1m0s
[06:51:45.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:31:0)
[06:51:45.055] Timer tick, asking Buildbucket for the build status
[06:51:45.110] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:45.110] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:32:0) after 1m0s
[06:52:45.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:32:0)
[06:52:45.135] Timer tick, asking Buildbucket for the build status
[06:52:45.244] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:45.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:33:0) after 1m0s
[06:53:45.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:33:0)
[06:53:45.305] Timer tick, asking Buildbucket for the build status
[06:53:45.440] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:45.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:34:0) after 1m0s
[06:54:45.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:34:0)
[06:54:45.517] Timer tick, asking Buildbucket for the build status
[06:54:45.583] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:45.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:35:0) after 1m0s
[06:55:45.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:35:0)
[06:55:45.744] Timer tick, asking Buildbucket for the build status
[06:55:45.808] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:45.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:36:0) after 1m0s
[06:56:45.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:36:0)
[06:56:45.928] Timer tick, asking Buildbucket for the build status
[06:56:45.988] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:45.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:37:0) after 1m0s
[06:57:46.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:37:0)
[06:57:46.068] Timer tick, asking Buildbucket for the build status
[06:57:46.178] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:46.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:38:0) after 1m0s
[06:58:46.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:38:0)
[06:58:46.214] Timer tick, asking Buildbucket for the build status
[06:58:46.280] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:46.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:39:0) after 1m0s
[06:59:46.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:39:0)
[06:59:46.292] Timer tick, asking Buildbucket for the build status
[06:59:46.452] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:46.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:40:0) after 1m0s
[07:00:46.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:40:0)
[07:00:46.543] Timer tick, asking Buildbucket for the build status
[07:00:46.633] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:46.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:41:0) after 1m0s
[07:01:46.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:41:0)
[07:01:46.692] Timer tick, asking Buildbucket for the build status
[07:01:46.768] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:46.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:42:0) after 1m0s
[07:02:46.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:42:0)
[07:02:46.867] Timer tick, asking Buildbucket for the build status
[07:02:47.079] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:47.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:43:0) after 1m0s
[07:03:47.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:43:0)
[07:03:47.099] Timer tick, asking Buildbucket for the build status
[07:03:47.288] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:47.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:44:0) after 1m0s
[07:04:47.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:44:0)
[07:04:47.308] Timer tick, asking Buildbucket for the build status
[07:04:47.436] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:47.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:45:0) after 1m0s
[07:05:47.524] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:45:0)
[07:05:47.524] Timer tick, asking Buildbucket for the build status
[07:05:47.726] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:47.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:46:0) after 1m0s
[07:06:47.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:46:0)
[07:06:47.749] Timer tick, asking Buildbucket for the build status
[07:06:48.204] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:48.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:47:0) after 1m0s
[07:07:48.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:47:0)
[07:07:48.227] Timer tick, asking Buildbucket for the build status
[07:07:48.337] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:48.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:48:0) after 1m0s
[07:08:48.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:48:0)
[07:08:48.418] Timer tick, asking Buildbucket for the build status
[07:08:48.492] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:48.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:49:0) after 1m0s
[07:09:48.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:49:0)
[07:09:48.559] Timer tick, asking Buildbucket for the build status
[07:09:48.638] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:48.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:50:0) after 1m0s
[07:10:48.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:50:0)
[07:10:48.658] Timer tick, asking Buildbucket for the build status
[07:10:48.710] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:48.710] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:51:0) after 1m0s
[07:11:48.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:51:0)
[07:11:48.743] Timer tick, asking Buildbucket for the build status
[07:11:48.857] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:48.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:52:0) after 1m0s
[07:12:48.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:52:0)
[07:12:48.879] Timer tick, asking Buildbucket for the build status
[07:12:48.981] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:48.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:53:0) after 1m0s
[07:13:48.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:53:0)
[07:13:48.962] Timer tick, asking Buildbucket for the build status
[07:13:49.203] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:49.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:54:0) after 1m0s
[07:14:49.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:54:0)
[07:14:49.250] Timer tick, asking Buildbucket for the build status
[07:14:49.444] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:49.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:55:0) after 1m0s
[07:15:49.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:55:0)
[07:15:49.441] Timer tick, asking Buildbucket for the build status
[07:15:49.505] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:49.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:56:0) after 1m0s
[07:16:49.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:56:0)
[07:16:49.605] Timer tick, asking Buildbucket for the build status
[07:16:49.683] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:49.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:57:0) after 1m0s
[07:17:49.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:57:0)
[07:17:49.683] Timer tick, asking Buildbucket for the build status
[07:17:49.797] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:49.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:58:0) after 1m0s
[07:18:49.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:58:0)
[07:18:49.818] Timer tick, asking Buildbucket for the build status
[07:18:49.881] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:49.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:59:0) after 1m0s
[07:19:49.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:59:0)
[07:19:49.933] Timer tick, asking Buildbucket for the build status
[07:19:49.986] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:49.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:60:0) after 1m0s
[07:20:50.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:60:0)
[07:20:50.062] Timer tick, asking Buildbucket for the build status
[07:20:50.115] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:50.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:61:0) after 1m0s
[07:21:50.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:61:0)
[07:21:50.256] Timer tick, asking Buildbucket for the build status
[07:21:50.305] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:50.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:62:0) after 1m0s
[07:22:50.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:62:0)
[07:22:50.365] Timer tick, asking Buildbucket for the build status
[07:22:50.603] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:50.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:63:0) after 1m0s
[07:23:50.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:63:0)
[07:23:50.631] Timer tick, asking Buildbucket for the build status
[07:23:50.684] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:50.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:64:0) after 1m0s
[07:24:50.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:64:0)
[07:24:50.713] Timer tick, asking Buildbucket for the build status
[07:24:50.775] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:50.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:65:0) after 1m0s
[07:25:50.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:65:0)
[07:25:50.796] Timer tick, asking Buildbucket for the build status
[07:25:50.937] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:50.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:66:0) after 1m0s
[07:26:50.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:66:0)
[07:26:50.965] Timer tick, asking Buildbucket for the build status
[07:26:51.056] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:51.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:67:0) after 1m0s
[07:27:51.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:67:0)
[07:27:51.115] Timer tick, asking Buildbucket for the build status
[07:27:51.222] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:51.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:68:0) after 1m0s
[07:28:51.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:68:0)
[07:28:51.247] Timer tick, asking Buildbucket for the build status
[07:28:51.385] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:51.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:69:0) after 1m0s
[07:29:51.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:69:0)
[07:29:51.407] Timer tick, asking Buildbucket for the build status
[07:29:51.472] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:51.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:70:0) after 1m0s
[07:30:51.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:70:0)
[07:30:51.567] Timer tick, asking Buildbucket for the build status
[07:30:51.636] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:51.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:71:0) after 1m0s
[07:31:51.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:71:0)
[07:31:51.733] Timer tick, asking Buildbucket for the build status
[07:31:51.948] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:51.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:72:0) after 1m0s
[07:32:52.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:72:0)
[07:32:52.017] Timer tick, asking Buildbucket for the build status
[07:32:52.398] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:52.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:73:0) after 1m0s
[07:33:52.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:73:0)
[07:33:52.563] Timer tick, asking Buildbucket for the build status
[07:33:52.617] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:52.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:74:0) after 1m0s
[07:34:52.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:74:0)
[07:34:52.680] Timer tick, asking Buildbucket for the build status
[07:34:52.745] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:52.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:75:0) after 1m0s
[07:35:52.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:75:0)
[07:35:52.817] Timer tick, asking Buildbucket for the build status
[07:35:52.877] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:52.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:76:0) after 1m0s
[07:36:52.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:76:0)
[07:36:52.884] Timer tick, asking Buildbucket for the build status
[07:36:52.964] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:52.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:77:0) after 1m0s
[07:37:53.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:77:0)
[07:37:53.084] Timer tick, asking Buildbucket for the build status
[07:37:53.207] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:53.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:78:0) after 1m0s
[07:38:53.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:78:0)
[07:38:53.212] Timer tick, asking Buildbucket for the build status
[07:38:53.267] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:53.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:79:0) after 1m0s
[07:39:53.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:79:0)
[07:39:53.445] Timer tick, asking Buildbucket for the build status
[07:39:53.495] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:53.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:80:0) after 1m0s
[07:40:53.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:80:0)
[07:40:53.641] Timer tick, asking Buildbucket for the build status
[07:40:53.956] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:53.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:81:0) after 1m0s
[07:41:53.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:81:0)
[07:41:53.969] Timer tick, asking Buildbucket for the build status
[07:41:54.140] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:54.140] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:82:0) after 1m0s
[07:42:54.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:82:0)
[07:42:54.201] Timer tick, asking Buildbucket for the build status
[07:42:54.314] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:54.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:83:0) after 1m0s
[07:43:54.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:83:0)
[07:43:54.458] Timer tick, asking Buildbucket for the build status
[07:43:54.731] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:54.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:84:0) after 1m0s
[07:44:54.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:84:0)
[07:44:54.785] Timer tick, asking Buildbucket for the build status
[07:44:55.023] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:55.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:85:0) after 1m0s
[07:45:55.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:85:0)
[07:45:55.058] Timer tick, asking Buildbucket for the build status
[07:45:55.326] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:55.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:86:0) after 1m0s
[07:46:55.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:86:0)
[07:46:55.408] Timer tick, asking Buildbucket for the build status
[07:46:55.491] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:55.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:87:0) after 1m0s
[07:47:55.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:87:0)
[07:47:55.532] Timer tick, asking Buildbucket for the build status
[07:47:55.723] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:55.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:88:0) after 1m0s
[07:48:55.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:88:0)
[07:48:55.736] Timer tick, asking Buildbucket for the build status
[07:48:56.241] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:56.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:89:0) after 1m0s
[07:49:56.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:89:0)
[07:49:56.330] Timer tick, asking Buildbucket for the build status
[07:49:56.598] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:56.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:90:0) after 1m0s
[07:50:56.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:90:0)
[07:50:56.723] Timer tick, asking Buildbucket for the build status
[07:50:56.899] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:56.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:91:0) after 1m0s
[07:51:56.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:91:0)
[07:51:56.986] Timer tick, asking Buildbucket for the build status
[07:51:57.214] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:57.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:92:0) after 1m0s
[07:52:57.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:92:0)
[07:52:57.257] Timer tick, asking Buildbucket for the build status
[07:52:57.448] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:57.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:93:0) after 1m0s
[07:53:57.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:93:0)
[07:53:57.579] Timer tick, asking Buildbucket for the build status
[07:53:57.750] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:57.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:94:0) after 1m0s
[07:54:57.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:94:0)
[07:54:57.779] Timer tick, asking Buildbucket for the build status
[07:54:59.650] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:59.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:95:0) after 1m0s
[07:55:59.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:95:0)
[07:55:59.837] Timer tick, asking Buildbucket for the build status
[07:56:00.151] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:00.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:96:0) after 1m0s
[07:57:00.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:96:0)
[07:57:00.208] Timer tick, asking Buildbucket for the build status
[07:57:00.287] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:00.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:97:0) after 1m0s
[07:58:00.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:97:0)
[07:58:00.357] Timer tick, asking Buildbucket for the build status
[07:58:00.695] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:00.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:98:0) after 1m0s
[07:59:00.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:98:0)
[07:59:00.759] Timer tick, asking Buildbucket for the build status
[07:59:00.837] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:00.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:99:0) after 1m0s
[08:00:00.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:99:0)
[08:00:00.950] Timer tick, asking Buildbucket for the build status
[08:00:01.757] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:01.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:100:0) after 1m0s
[08:01:01.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:100:0)
[08:01:01.930] Timer tick, asking Buildbucket for the build status
[08:01:02.071] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:02.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:101:0) after 1m0s
[08:02:02.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:101:0)
[08:02:02.169] Timer tick, asking Buildbucket for the build status
[08:02:03.313] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:03.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:102:0) after 1m0s
[08:03:03.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:102:0)
[08:03:03.413] Timer tick, asking Buildbucket for the build status
[08:03:03.577] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:03.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:103:0) after 1m0s
[08:04:03.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:103:0)
[08:04:03.692] Timer tick, asking Buildbucket for the build status
[08:04:03.780] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:03.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:104:0) after 1m0s
[08:05:03.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:104:0)
[08:05:03.816] Timer tick, asking Buildbucket for the build status
[08:05:04.024] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:04.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:105:0) after 1m0s
[08:06:04.080] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:105:0)
[08:06:04.080] Timer tick, asking Buildbucket for the build status
[08:06:04.158] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:04.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:106:0) after 1m0s
[08:07:04.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:106:0)
[08:07:04.184] Timer tick, asking Buildbucket for the build status
[08:07:04.261] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:04.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:107:0) after 1m0s
[08:08:04.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:107:0)
[08:08:04.414] Timer tick, asking Buildbucket for the build status
[08:08:04.611] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:04.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:108:0) after 1m0s
[08:09:04.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:108:0)
[08:09:04.698] Timer tick, asking Buildbucket for the build status
[08:09:04.769] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:04.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:109:0) after 1m0s
[08:10:04.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:109:0)
[08:10:04.803] Timer tick, asking Buildbucket for the build status
[08:10:04.920] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:04.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:110:0) after 1m0s
[08:11:05.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:110:0)
[08:11:05.451] Timer tick, asking Buildbucket for the build status
[08:11:05.526] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:05.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:111:0) after 1m0s
[08:12:05.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:111:0)
[08:12:05.735] Timer tick, asking Buildbucket for the build status
[08:12:05.812] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:05.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:112:0) after 1m0s
[08:13:05.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:112:0)
[08:13:05.858] Timer tick, asking Buildbucket for the build status
[08:13:05.964] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:05.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:113:0) after 1m0s
[08:14:06.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:113:0)
[08:14:06.018] Timer tick, asking Buildbucket for the build status
[08:14:06.072] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:06.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:114:0) after 1m0s
[08:15:06.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:114:0)
[08:15:06.204] Timer tick, asking Buildbucket for the build status
[08:15:06.259] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:06.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:115:0) after 1m0s
[08:16:06.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:115:0)
[08:16:06.327] Timer tick, asking Buildbucket for the build status
[08:16:06.828] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:06.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:116:0) after 1m0s
[08:17:06.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:116:0)
[08:17:06.990] Timer tick, asking Buildbucket for the build status
[08:17:07.056] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:07.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:117:0) after 1m0s
[08:18:07.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:117:0)
[08:18:07.128] Timer tick, asking Buildbucket for the build status
[08:18:07.221] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:07.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:118:0) after 1m0s
[08:19:07.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:118:0)
[08:19:07.338] Timer tick, asking Buildbucket for the build status
[08:19:07.400] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:07.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:119:0) after 1m0s
[08:20:07.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:119:0)
[08:20:07.548] Timer tick, asking Buildbucket for the build status
[08:20:07.703] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:07.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:120:0) after 1m0s
[08:21:07.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:120:0)
[08:21:07.770] Timer tick, asking Buildbucket for the build status
[08:21:10.471] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:10.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:121:0) after 1m0s
[08:22:10.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:121:0)
[08:22:10.571] Timer tick, asking Buildbucket for the build status
[08:22:10.691] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:10.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:122:0) after 1m0s
[08:23:10.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:122:0)
[08:23:10.833] Timer tick, asking Buildbucket for the build status
[08:23:10.960] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:10.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:123:0) after 1m0s
[08:24:11.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:123:0)
[08:24:11.165] Timer tick, asking Buildbucket for the build status
[08:24:11.225] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:11.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:124:0) after 1m0s
[08:25:11.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:124:0)
[08:25:11.296] Timer tick, asking Buildbucket for the build status
[08:25:12.101] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:12.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:125:0) after 1m0s
[08:26:12.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:125:0)
[08:26:12.309] Timer tick, asking Buildbucket for the build status
[08:26:12.393] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:12.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:126:0) after 1m0s
[08:27:12.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:126:0)
[08:27:12.532] Timer tick, asking Buildbucket for the build status
[08:27:12.592] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:12.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:127:0) after 1m0s
[08:28:12.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:127:0)
[08:28:12.668] Timer tick, asking Buildbucket for the build status
[08:28:12.771] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:12.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:128:0) after 1m0s
[08:29:12.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:128:0)
[08:29:12.822] Timer tick, asking Buildbucket for the build status
[08:29:13.042] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:13.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:129:0) after 1m0s
[08:30:13.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:129:0)
[08:30:13.145] Timer tick, asking Buildbucket for the build status
[08:30:13.209] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:13.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:130:0) after 1m0s
[08:31:13.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:130:0)
[08:31:13.339] Timer tick, asking Buildbucket for the build status
[08:31:13.409] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:13.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:131:0) after 1m0s
[08:32:13.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:131:0)
[08:32:13.500] Timer tick, asking Buildbucket for the build status
[08:32:13.561] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:13.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:132:0) after 1m0s
[08:33:13.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:132:0)
[08:33:13.639] Timer tick, asking Buildbucket for the build status
[08:33:14.169] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:14.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:133:0) after 1m0s
[08:34:14.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:133:0)
[08:34:14.301] Timer tick, asking Buildbucket for the build status
[08:34:14.361] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:14.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:134:0) after 1m0s
[08:35:14.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:134:0)
[08:35:14.492] Timer tick, asking Buildbucket for the build status
[08:35:14.558] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:14.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:135:0) after 1m0s
[08:36:14.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:135:0)
[08:36:14.690] Timer tick, asking Buildbucket for the build status
[08:36:14.774] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:14.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:136:0) after 1m0s
[08:37:14.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:136:0)
[08:37:14.820] Timer tick, asking Buildbucket for the build status
[08:37:14.939] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:14.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:137:0) after 1m0s
[08:38:15.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:137:0)
[08:38:15.172] Timer tick, asking Buildbucket for the build status
[08:38:15.339] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:15.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:138:0) after 1m0s
[08:39:15.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:138:0)
[08:39:15.371] Timer tick, asking Buildbucket for the build status
[08:39:15.537] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:15.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:139:0) after 1m0s
[08:40:15.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:139:0)
[08:40:15.600] Timer tick, asking Buildbucket for the build status
[08:40:15.737] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:15.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:140:0) after 1m0s
[08:41:15.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:140:0)
[08:41:15.728] Timer tick, asking Buildbucket for the build status
[08:41:15.790] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:15.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:141:0) after 1m0s
[08:42:15.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:141:0)
[08:42:15.862] Timer tick, asking Buildbucket for the build status
[08:42:15.910] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:15.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:142:0) after 1m0s
[08:43:16.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:142:0)
[08:43:16.060] Timer tick, asking Buildbucket for the build status
[08:43:16.208] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:16.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:143:0) after 1m0s
[08:44:16.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:143:0)
[08:44:16.204] Timer tick, asking Buildbucket for the build status
[08:44:16.267] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:16.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:144:0) after 1m0s
[08:45:16.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:144:0)
[08:45:16.351] Timer tick, asking Buildbucket for the build status
[08:45:16.418] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:16.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:145:0) after 1m0s
[08:46:16.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:145:0)
[08:46:16.522] Timer tick, asking Buildbucket for the build status
[08:46:16.701] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:16.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:146:0) after 1m0s
[08:47:16.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:146:0)
[08:47:16.715] Timer tick, asking Buildbucket for the build status
[08:47:16.938] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:16.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:147:0) after 1m0s
[08:48:16.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:147:0)
[08:48:16.976] Timer tick, asking Buildbucket for the build status
[08:48:17.100] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:17.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:148:0) after 1m0s
[08:49:17.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:148:0)
[08:49:17.270] Timer tick, asking Buildbucket for the build status
[08:49:17.433] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:17.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:149:0) after 1m0s
[08:50:17.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:149:0)
[08:50:17.528] Timer tick, asking Buildbucket for the build status
[08:50:17.596] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:17.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:150:0) after 1m0s
[08:51:17.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:150:0)
[08:51:17.661] Timer tick, asking Buildbucket for the build status
[08:51:17.728] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:17.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:151:0) after 1m0s
[08:52:18.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:151:0)
[08:52:18.112] Timer tick, asking Buildbucket for the build status
[08:52:18.217] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:18.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:152:0) after 1m0s
[08:53:18.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:152:0)
[08:53:18.717] Timer tick, asking Buildbucket for the build status
[08:53:19.108] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:19.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:153:0) after 1m0s
[08:54:19.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:153:0)
[08:54:19.225] Timer tick, asking Buildbucket for the build status
[08:54:19.589] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:19.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:154:0) after 1m0s
[08:55:19.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:154:0)
[08:55:19.657] Timer tick, asking Buildbucket for the build status
[08:55:19.832] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:19.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:155:0) after 1m0s
[08:56:19.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:155:0)
[08:56:19.899] Timer tick, asking Buildbucket for the build status
[08:56:19.971] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:19.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:156:0) after 1m0s
[08:57:20.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:156:0)
[08:57:20.051] Timer tick, asking Buildbucket for the build status
[08:57:20.222] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:20.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:157:0) after 1m0s
[08:58:20.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:157:0)
[08:58:20.304] Timer tick, asking Buildbucket for the build status
[08:58:20.693] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:20.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:158:0) after 1m0s
[08:59:20.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:158:0)
[08:59:20.862] Timer tick, asking Buildbucket for the build status
[08:59:20.924] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:20.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:159:0) after 1m0s
[09:00:21.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:159:0)
[09:00:21.063] Timer tick, asking Buildbucket for the build status
[09:00:21.347] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:21.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:160:0) after 1m0s
[09:01:21.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:160:0)
[09:01:21.523] Timer tick, asking Buildbucket for the build status
[09:01:21.586] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:21.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:161:0) after 1m0s
[09:02:21.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:161:0)
[09:02:21.749] Timer tick, asking Buildbucket for the build status
[09:02:21.909] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:21.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:162:0) after 1m0s
[09:03:21.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:162:0)
[09:03:21.982] Timer tick, asking Buildbucket for the build status
[09:03:22.293] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:22.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:163:0) after 1m0s
[09:04:22.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:163:0)
[09:04:22.402] Timer tick, asking Buildbucket for the build status
[09:04:22.470] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:22.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:164:0) after 1m0s
[09:05:22.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:164:0)
[09:05:22.565] Timer tick, asking Buildbucket for the build status
[09:05:22.921] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:22.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:165:0) after 1m0s
[09:06:22.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:165:0)
[09:06:22.979] Timer tick, asking Buildbucket for the build status
[09:06:23.050] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:23.050] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:166:0) after 1m0s
[09:07:23.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:166:0)
[09:07:23.046] Timer tick, asking Buildbucket for the build status
[09:07:23.111] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:23.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:167:0) after 1m0s
[09:08:23.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:167:0)
[09:08:23.136] Timer tick, asking Buildbucket for the build status
[09:08:23.231] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:23.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:168:0) after 1m0s
[09:09:23.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:168:0)
[09:09:23.275] Timer tick, asking Buildbucket for the build status
[09:09:23.381] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:23.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:169:0) after 1m0s
[09:10:23.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:169:0)
[09:10:23.439] Timer tick, asking Buildbucket for the build status
[09:10:23.507] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:23.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:170:0) after 1m0s
[09:11:23.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:170:0)
[09:11:23.677] Timer tick, asking Buildbucket for the build status
[09:11:23.746] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:23.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:171:0) after 1m0s
[09:12:23.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:171:0)
[09:12:23.839] Timer tick, asking Buildbucket for the build status
[09:12:23.923] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:23.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:172:0) after 1m0s
[09:13:23.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:172:0)
[09:13:23.988] Timer tick, asking Buildbucket for the build status
[09:13:24.185] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:24.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:173:0) after 1m0s
[09:14:24.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:173:0)
[09:14:24.266] Timer tick, asking Buildbucket for the build status
[09:14:24.384] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:24.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:174:0) after 1m0s
[09:15:24.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:174:0)
[09:15:24.620] Timer tick, asking Buildbucket for the build status
[09:15:24.903] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:24.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:175:0) after 1m0s
[09:16:24.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:175:0)
[09:16:24.938] Timer tick, asking Buildbucket for the build status
[09:16:25.145] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:25.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:176:0) after 1m0s
[09:17:25.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:176:0)
[09:17:25.271] Timer tick, asking Buildbucket for the build status
[09:17:25.631] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:25.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:177:0) after 1m0s
[09:18:25.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:177:0)
[09:18:25.737] Timer tick, asking Buildbucket for the build status
[09:18:25.928] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:25.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:178:0) after 1m0s
[09:19:26.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:178:0)
[09:19:26.026] Timer tick, asking Buildbucket for the build status
[09:19:26.315] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:26.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:179:0) after 1m0s
[09:20:26.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:179:0)
[09:20:26.343] Timer tick, asking Buildbucket for the build status
[09:20:26.402] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:26.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:180:0) after 1m0s
[09:21:26.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:180:0)
[09:21:26.409] Timer tick, asking Buildbucket for the build status
[09:21:26.471] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:26.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:181:0) after 1m0s
[09:22:26.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:181:0)
[09:22:26.481] Timer tick, asking Buildbucket for the build status
[09:22:26.561] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:26.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:182:0) after 1m0s
[09:23:26.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:182:0)
[09:23:26.705] Timer tick, asking Buildbucket for the build status
[09:23:26.837] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:26.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:183:0) after 1m0s
[09:24:26.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:183:0)
[09:24:26.871] Timer tick, asking Buildbucket for the build status
[09:24:26.935] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:26.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:184:0) after 1m0s
[09:25:27.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:184:0)
[09:25:27.021] Timer tick, asking Buildbucket for the build status
[09:25:27.079] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:27.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:185:0) after 1m0s
[09:26:27.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:185:0)
[09:26:27.333] Timer tick, asking Buildbucket for the build status
[09:26:27.440] Build 8862772037463784720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:27.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9028202099618295728:186:0) after 1m0s
[09:26:47.913] Received PubSub notification, asking Buildbucket for the build status
[09:26:47.969] Build 8862772037463784720: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:26:47.969] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1606210006979785",
    "created_by": "project:infra",
    "created_ts": "1606198957915367",
    "id": "8862772037463784720",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4240.199\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"010ddabe-bf6b-4029-a1be-66dee280ca48\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4240.199\"}}",
    "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-p8zj\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1606198975002348",
    "status": "COMPLETED",
    "status_changed_ts": "1606210007507975",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9028202099618295728",
      "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/8862772037463784720/+/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:5011bca169986f10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1606210007629421",
    "url": "https://ci.chromium.org/b/8862772037463784720",
    "utcnow_ts": "1606210007962524"
  }
}
[09:26:47.969] Invocation finished in 3h4m11.491506744s with status SUCCEEDED