buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.r8.ci"
  builder: "linux-internal"
>

• e8af15654c1f7b68d802722ddc919e7db3c75cfb (6 years ago)

{
  "branch": "refs/heads/master",
  "repository": "https://r8.googlesource.com/r8",
  "revision": "e8af15654c1f7b68d802722ddc919e7db3c75cfb"
}

• buildset:commit/git/e8af15654c1f7b68d802722ddc919e7db3c75cfb
• buildset:commit/gitiles/r8.googlesource.com/r8/+/e8af15654c1f7b68d802722ddc919e7db3c75cfb
• gitiles_ref:refs/heads/master

[19:45:34.501] New invocation is queued and will start shortly
[19:45:35.689] Starting the invocation (attempt 1)
[19:45:35.728] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:45:35.728] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:45:35.728] Buildbucket request:
{
  "bucket": "luci.r8.ci",
  "client_operation_id": "9072634691824112112",
  "parameters_json": "{\"builder_name\":\"linux-internal\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"e8af15654c1f7b68d802722ddc919e7db3c75cfb\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@e8af15654c1f7b68d802722ddc919e7db3c75cfb\",\"title\":\"e8af15654c1f7b68d802722ddc919e7db3c75cfb\",\"url\":\"https://r8.googlesource.com/r8/+/e8af15654c1f7b68d802722ddc919e7db3c75cfb\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"e8af15654c1f7b68d802722ddc919e7db3c75cfb\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-internal",
    "scheduler_invocation_id:9072634691824112112",
    "scheduler_job_id:r8/linux-internal",
    "user_agent:luci-scheduler",
    "buildset:commit/git/e8af15654c1f7b68d802722ddc919e7db3c75cfb",
    "buildset:commit/gitiles/r8.googlesource.com/r8/+/e8af15654c1f7b68d802722ddc919e7db3c75cfb",
    "gitiles_ref:refs/heads/master"
  ]
}
[19:45:36.994] Buildbucket response:
{
  "build": {
    "bucket": "luci.r8.ci",
    "canary_preference": "PROD",
    "created_by": "project:r8",
    "created_ts": "1563824735841963",
    "id": "8907204629748996160",
    "parameters_json": "{\"builder_name\": \"linux-internal\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"e8af15654c1f7b68d802722ddc919e7db3c75cfb\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@e8af15654c1f7b68d802722ddc919e7db3c75cfb\", \"title\": \"e8af15654c1f7b68d802722ddc919e7db3c75cfb\", \"url\": \"https://r8.googlesource.com/r8/+/e8af15654c1f7b68d802722ddc919e7db3c75cfb\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"e8af15654c1f7b68d802722ddc919e7db3c75cfb\"}}",
    "project": "r8",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1563824736571311",
    "tags": [
      "build_address:luci.r8.ci/linux-internal/434",
      "builder:linux-internal",
      "buildset:commit/git/e8af15654c1f7b68d802722ddc919e7db3c75cfb",
      "buildset:commit/gitiles/r8.googlesource.com/r8/+/e8af15654c1f7b68d802722ddc919e7db3c75cfb",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9072634691824112112",
      "scheduler_job_id:r8/linux-internal",
      "swarming_hostname:chrome-swarming.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/r8/buildbucket/cr-buildbucket.appspot.com/8907204629748996160/+/annotations",
      "swarming_tag:luci_project:r8",
      "swarming_tag:recipe_name:rex",
      "swarming_tag:recipe_package:infra_internal/recipe_bundles/chrome-internal.googlesource.com/chrome/tools/build_limited/scripts/slave",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1563824736571430",
    "url": "https://ci.chromium.org/b/8907204629748996160",
    "utcnow_ts": "1563824736959310"
  }
}
[19:45:36.994] Task URL: https://ci.chromium.org/b/8907204629748996160
[19:45:36.994] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:2:0) after 1m0s
[19:45:42.439] Received PubSub notification, asking Buildbucket for the build status
[19:45:42.528] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:37.065] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:2:0)
[19:46:37.065] Timer tick, asking Buildbucket for the build status
[19:46:37.487] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:37.487] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:4:0) after 1m0s
[19:47:37.518] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:4:0)
[19:47:37.518] Timer tick, asking Buildbucket for the build status
[19:47:37.772] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:37.772] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:5:0) after 1m0s
[19:48:37.921] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:5:0)
[19:48:37.921] Timer tick, asking Buildbucket for the build status
[19:48:38.032] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:38.032] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:6:0) after 1m0s
[19:49:38.080] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:6:0)
[19:49:38.080] Timer tick, asking Buildbucket for the build status
[19:49:38.633] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:38.633] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:7:0) after 1m0s
[19:50:38.676] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:7:0)
[19:50:38.676] Timer tick, asking Buildbucket for the build status
[19:50:39.071] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:39.071] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:8:0) after 1m0s
[19:51:39.164] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:8:0)
[19:51:39.164] Timer tick, asking Buildbucket for the build status
[19:51:39.510] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:39.510] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:9:0) after 1m0s
[19:52:39.539] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:9:0)
[19:52:39.539] Timer tick, asking Buildbucket for the build status
[19:52:39.825] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:39.825] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:10:0) after 1m0s
[19:53:39.879] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:10:0)
[19:53:39.879] Timer tick, asking Buildbucket for the build status
[19:53:40.083] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:40.083] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:11:0) after 1m0s
[19:54:40.125] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:11:0)
[19:54:40.125] Timer tick, asking Buildbucket for the build status
[19:54:40.272] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:40.272] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:12:0) after 1m0s
[19:55:40.306] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:12:0)
[19:55:40.306] Timer tick, asking Buildbucket for the build status
[19:55:40.456] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:40.456] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:13:0) after 1m0s
[19:56:40.566] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:13:0)
[19:56:40.566] Timer tick, asking Buildbucket for the build status
[19:56:41.786] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:41.786] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:14:0) after 1m0s
[19:57:41.843] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:14:0)
[19:57:41.843] Timer tick, asking Buildbucket for the build status
[19:57:41.968] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:41.968] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:15:0) after 1m0s
[19:58:42.128] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:15:0)
[19:58:42.128] Timer tick, asking Buildbucket for the build status
[19:58:42.339] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:42.339] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:16:0) after 1m0s
[19:59:42.466] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:16:0)
[19:59:42.466] Timer tick, asking Buildbucket for the build status
[19:59:43.526] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:43.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:17:0) after 1m0s
[20:00:43.649] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:17:0)
[20:00:43.649] Timer tick, asking Buildbucket for the build status
[20:00:43.931] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:43.931] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:18:0) after 1m0s
[20:01:43.961] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:18:0)
[20:01:43.961] Timer tick, asking Buildbucket for the build status
[20:01:44.303] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:44.303] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:19:0) after 1m0s
[20:02:44.293] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:19:0)
[20:02:44.293] Timer tick, asking Buildbucket for the build status
[20:02:44.854] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:44.854] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:20:0) after 1m0s
[20:03:44.994] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:20:0)
[20:03:44.994] Timer tick, asking Buildbucket for the build status
[20:03:45.237] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:45.237] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:21:0) after 1m0s
[20:04:45.331] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:21:0)
[20:04:45.331] Timer tick, asking Buildbucket for the build status
[20:04:45.975] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:45.975] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:22:0) after 1m0s
[20:05:45.998] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:22:0)
[20:05:45.998] Timer tick, asking Buildbucket for the build status
[20:05:46.355] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:46.355] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:23:0) after 1m0s
[20:06:46.377] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:23:0)
[20:06:46.377] Timer tick, asking Buildbucket for the build status
[20:06:48.687] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:48.687] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:24:0) after 1m0s
[20:07:48.744] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:24:0)
[20:07:48.744] Timer tick, asking Buildbucket for the build status
[20:07:48.873] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:48.873] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:25:0) after 1m0s
[20:08:48.923] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:25:0)
[20:08:48.923] Timer tick, asking Buildbucket for the build status
[20:08:49.398] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:49.398] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:26:0) after 1m0s
[20:09:49.445] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:26:0)
[20:09:49.445] Timer tick, asking Buildbucket for the build status
[20:09:49.546] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:49.546] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:27:0) after 1m0s
[20:10:49.623] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:27:0)
[20:10:49.623] Timer tick, asking Buildbucket for the build status
[20:10:49.965] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:49.965] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:28:0) after 1m0s
[20:11:50.022] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:28:0)
[20:11:50.022] Timer tick, asking Buildbucket for the build status
[20:11:50.354] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:50.354] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:29:0) after 1m0s
[20:12:50.376] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:29:0)
[20:12:50.376] Timer tick, asking Buildbucket for the build status
[20:12:50.729] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:50.729] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:30:0) after 1m0s
[20:13:50.762] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:30:0)
[20:13:50.762] Timer tick, asking Buildbucket for the build status
[20:13:50.982] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:50.982] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:31:0) after 1m0s
[20:14:51.067] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:31:0)
[20:14:51.067] Timer tick, asking Buildbucket for the build status
[20:14:51.465] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:51.465] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:32:0) after 1m0s
[20:15:51.529] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:32:0)
[20:15:51.529] Timer tick, asking Buildbucket for the build status
[20:15:51.849] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:51.849] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:33:0) after 1m0s
[20:16:51.973] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:33:0)
[20:16:51.973] Timer tick, asking Buildbucket for the build status
[20:16:52.155] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:52.155] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:34:0) after 1m0s
[20:17:52.271] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:34:0)
[20:17:52.271] Timer tick, asking Buildbucket for the build status
[20:17:52.382] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:52.382] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:35:0) after 1m0s
[20:18:52.551] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:35:0)
[20:18:52.551] Timer tick, asking Buildbucket for the build status
[20:18:52.712] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:52.712] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:36:0) after 1m0s
[20:19:52.747] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:36:0)
[20:19:52.747] Timer tick, asking Buildbucket for the build status
[20:19:53.085] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:53.085] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:37:0) after 1m0s
[20:20:53.115] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:37:0)
[20:20:53.115] Timer tick, asking Buildbucket for the build status
[20:20:53.347] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:53.347] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:38:0) after 1m0s
[20:21:53.376] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:38:0)
[20:21:53.376] Timer tick, asking Buildbucket for the build status
[20:21:53.782] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:53.782] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:39:0) after 1m0s
[20:22:53.867] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:39:0)
[20:22:53.867] Timer tick, asking Buildbucket for the build status
[20:22:53.994] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:53.994] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:40:0) after 1m0s
[20:23:54.165] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:40:0)
[20:23:54.165] Timer tick, asking Buildbucket for the build status
[20:23:55.308] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:55.308] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:41:0) after 1m0s
[20:24:55.330] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:41:0)
[20:24:55.330] Timer tick, asking Buildbucket for the build status
[20:24:55.516] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:55.516] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:42:0) after 1m0s
[20:25:55.518] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:42:0)
[20:25:55.518] Timer tick, asking Buildbucket for the build status
[20:25:56.157] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:56.157] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:43:0) after 1m0s
[20:26:56.208] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:43:0)
[20:26:56.208] Timer tick, asking Buildbucket for the build status
[20:26:56.310] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:56.311] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:44:0) after 1m0s
[20:27:56.336] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:44:0)
[20:27:56.336] Timer tick, asking Buildbucket for the build status
[20:27:56.611] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:56.611] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:45:0) after 1m0s
[20:28:56.637] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:45:0)
[20:28:56.637] Timer tick, asking Buildbucket for the build status
[20:28:56.936] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:56.936] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:46:0) after 1m0s
[20:29:56.963] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:46:0)
[20:29:56.963] Timer tick, asking Buildbucket for the build status
[20:29:57.140] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:57.140] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:47:0) after 1m0s
[20:30:57.172] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:47:0)
[20:30:57.172] Timer tick, asking Buildbucket for the build status
[20:31:05.311] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:05.311] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:48:0) after 1m0s
[20:32:05.338] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:48:0)
[20:32:05.338] Timer tick, asking Buildbucket for the build status
[20:32:05.647] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:05.647] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:49:0) after 1m0s
[20:33:05.817] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:49:0)
[20:33:05.817] Timer tick, asking Buildbucket for the build status
[20:33:06.105] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:06.108] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:50:0) after 1m0s
[20:34:06.160] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:50:0)
[20:34:06.160] Timer tick, asking Buildbucket for the build status
[20:34:06.368] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:06.368] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:51:0) after 1m0s
[20:35:06.418] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:51:0)
[20:35:06.418] Timer tick, asking Buildbucket for the build status
[20:35:06.548] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:06.548] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:52:0) after 1m0s
[20:36:06.663] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:52:0)
[20:36:06.663] Timer tick, asking Buildbucket for the build status
[20:36:06.940] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:06.940] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:53:0) after 1m0s
[20:37:07.007] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:53:0)
[20:37:07.007] Timer tick, asking Buildbucket for the build status
[20:37:08.471] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:08.471] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:54:0) after 1m0s
[20:38:08.536] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:54:0)
[20:38:08.536] Timer tick, asking Buildbucket for the build status
[20:38:08.676] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:08.676] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:55:0) after 1m0s
[20:39:08.768] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:55:0)
[20:39:08.768] Timer tick, asking Buildbucket for the build status
[20:39:10.287] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:10.287] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:56:0) after 1m0s
[20:40:10.356] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:56:0)
[20:40:10.356] Timer tick, asking Buildbucket for the build status
[20:40:10.627] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:10.627] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:57:0) after 1m0s
[20:41:10.638] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:57:0)
[20:41:10.638] Timer tick, asking Buildbucket for the build status
[20:41:10.842] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:10.842] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:58:0) after 1m0s
[20:42:10.874] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:58:0)
[20:42:10.874] Timer tick, asking Buildbucket for the build status
[20:42:12.231] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:12.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:59:0) after 1m0s
[20:43:12.255] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:59:0)
[20:43:12.255] Timer tick, asking Buildbucket for the build status
[20:43:13.937] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:13.937] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:60:0) after 1m0s
[20:44:13.958] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:60:0)
[20:44:13.958] Timer tick, asking Buildbucket for the build status
[20:44:14.310] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:14.310] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:61:0) after 1m0s
[20:45:14.322] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:61:0)
[20:45:14.322] Timer tick, asking Buildbucket for the build status
[20:45:14.751] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:14.751] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:62:0) after 1m0s
[20:46:14.774] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:62:0)
[20:46:14.774] Timer tick, asking Buildbucket for the build status
[20:46:15.226] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:15.226] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:63:0) after 1m0s
[20:47:15.252] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:63:0)
[20:47:15.252] Timer tick, asking Buildbucket for the build status
[20:47:15.390] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:15.390] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:64:0) after 1m0s
[20:48:15.441] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:64:0)
[20:48:15.441] Timer tick, asking Buildbucket for the build status
[20:48:15.968] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:15.968] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:65:0) after 1m0s
[20:49:16.047] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:65:0)
[20:49:16.047] Timer tick, asking Buildbucket for the build status
[20:49:17.513] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:17.513] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:66:0) after 1m0s
[20:50:17.487] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:66:0)
[20:50:17.487] Timer tick, asking Buildbucket for the build status
[20:50:17.804] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:17.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:67:0) after 1m0s
[20:51:17.808] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:67:0)
[20:51:17.808] Timer tick, asking Buildbucket for the build status
[20:51:17.914] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:17.914] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:68:0) after 1m0s
[20:52:18.001] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:68:0)
[20:52:18.001] Timer tick, asking Buildbucket for the build status
[20:52:18.135] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:18.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:69:0) after 1m0s
[20:53:18.201] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:69:0)
[20:53:18.201] Timer tick, asking Buildbucket for the build status
[20:53:18.606] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:18.606] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:70:0) after 1m0s
[20:54:18.663] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:70:0)
[20:54:18.663] Timer tick, asking Buildbucket for the build status
[20:54:18.854] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:18.854] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:71:0) after 1m0s
[20:55:18.949] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:71:0)
[20:55:18.949] Timer tick, asking Buildbucket for the build status
[20:55:19.845] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:19.845] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:72:0) after 1m0s
[20:56:19.870] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:72:0)
[20:56:19.870] Timer tick, asking Buildbucket for the build status
[20:56:20.125] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:20.126] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:73:0) after 1m0s
[20:57:20.252] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:73:0)
[20:57:20.252] Timer tick, asking Buildbucket for the build status
[20:57:20.399] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:20.399] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:74:0) after 1m0s
[20:58:20.467] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:74:0)
[20:58:20.467] Timer tick, asking Buildbucket for the build status
[20:58:21.080] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:21.080] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:75:0) after 1m0s
[20:59:21.108] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:75:0)
[20:59:21.108] Timer tick, asking Buildbucket for the build status
[20:59:21.322] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:21.322] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:76:0) after 1m0s
[21:00:21.389] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:76:0)
[21:00:21.389] Timer tick, asking Buildbucket for the build status
[21:00:21.698] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:21.698] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:77:0) after 1m0s
[21:01:21.723] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:77:0)
[21:01:21.723] Timer tick, asking Buildbucket for the build status
[21:01:21.899] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:21.899] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:78:0) after 1m0s
[21:02:21.971] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:78:0)
[21:02:21.971] Timer tick, asking Buildbucket for the build status
[21:02:22.385] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:22.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:79:0) after 1m0s
[21:03:22.431] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:79:0)
[21:03:22.431] Timer tick, asking Buildbucket for the build status
[21:03:23.897] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:23.897] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:80:0) after 1m0s
[21:04:23.921] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:80:0)
[21:04:23.921] Timer tick, asking Buildbucket for the build status
[21:04:24.261] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:24.261] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:81:0) after 1m0s
[21:05:24.311] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:81:0)
[21:05:24.311] Timer tick, asking Buildbucket for the build status
[21:05:24.548] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:24.548] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:82:0) after 1m0s
[21:06:24.810] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:82:0)
[21:06:24.810] Timer tick, asking Buildbucket for the build status
[21:06:25.002] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:25.002] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:83:0) after 1m0s
[21:07:25.187] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:83:0)
[21:07:25.187] Timer tick, asking Buildbucket for the build status
[21:07:25.386] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:25.386] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:84:0) after 1m0s
[21:08:25.455] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:84:0)
[21:08:25.455] Timer tick, asking Buildbucket for the build status
[21:08:25.775] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:25.775] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:85:0) after 1m0s
[21:09:26.016] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:85:0)
[21:09:26.016] Timer tick, asking Buildbucket for the build status
[21:09:27.020] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:27.020] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:86:0) after 1m0s
[21:10:27.185] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:86:0)
[21:10:27.185] Timer tick, asking Buildbucket for the build status
[21:10:27.752] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:27.752] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:87:0) after 1m0s
[21:11:27.810] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:87:0)
[21:11:27.810] Timer tick, asking Buildbucket for the build status
[21:11:28.142] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:28.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:88:0) after 1m0s
[21:12:28.168] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:88:0)
[21:12:28.168] Timer tick, asking Buildbucket for the build status
[21:12:28.314] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:28.314] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:89:0) after 1m0s
[21:13:28.410] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:89:0)
[21:13:28.410] Timer tick, asking Buildbucket for the build status
[21:13:28.568] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:28.568] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:90:0) after 1m0s
[21:14:28.604] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:90:0)
[21:14:28.604] Timer tick, asking Buildbucket for the build status
[21:14:29.627] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:29.627] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:91:0) after 1m0s
[21:15:29.675] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:91:0)
[21:15:29.675] Timer tick, asking Buildbucket for the build status
[21:15:30.506] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:30.506] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:92:0) after 1m0s
[21:16:30.505] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:92:0)
[21:16:30.505] Timer tick, asking Buildbucket for the build status
[21:16:30.656] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:30.656] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:93:0) after 1m0s
[21:17:30.708] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:93:0)
[21:17:30.708] Timer tick, asking Buildbucket for the build status
[21:17:31.776] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:31.776] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:94:0) after 1m0s
[21:18:31.776] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:94:0)
[21:18:31.776] Timer tick, asking Buildbucket for the build status
[21:18:31.956] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:31.956] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:95:0) after 1m0s
[21:19:32.005] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:95:0)
[21:19:32.005] Timer tick, asking Buildbucket for the build status
[21:19:32.709] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:32.709] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:96:0) after 1m0s
[21:20:32.749] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:96:0)
[21:20:32.749] Timer tick, asking Buildbucket for the build status
[21:20:32.904] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:32.904] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:97:0) after 1m0s
[21:21:32.930] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:97:0)
[21:21:32.930] Timer tick, asking Buildbucket for the build status
[21:21:33.106] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:33.106] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:98:0) after 1m0s
[21:22:33.159] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:98:0)
[21:22:33.159] Timer tick, asking Buildbucket for the build status
[21:22:33.614] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:33.614] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:99:0) after 1m0s
[21:23:33.649] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:99:0)
[21:23:33.649] Timer tick, asking Buildbucket for the build status
[21:23:33.877] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:33.877] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:100:0) after 1m0s
[21:24:34.065] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:100:0)
[21:24:34.065] Timer tick, asking Buildbucket for the build status
[21:24:34.788] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:34.788] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:101:0) after 1m0s
[21:25:34.916] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:101:0)
[21:25:34.916] Timer tick, asking Buildbucket for the build status
[21:25:35.867] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:35.867] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:102:0) after 1m0s
[21:26:35.931] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:102:0)
[21:26:35.931] Timer tick, asking Buildbucket for the build status
[21:26:36.072] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:36.072] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:103:0) after 1m0s
[21:27:36.167] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:103:0)
[21:27:36.167] Timer tick, asking Buildbucket for the build status
[21:27:36.420] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:36.420] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:104:0) after 1m0s
[21:28:36.463] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:104:0)
[21:28:36.463] Timer tick, asking Buildbucket for the build status
[21:28:37.476] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:37.476] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:105:0) after 1m0s
[21:29:37.578] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:105:0)
[21:29:37.578] Timer tick, asking Buildbucket for the build status
[21:29:40.887] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:40.887] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:106:0) after 1m0s
[21:30:40.970] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:106:0)
[21:30:40.970] Timer tick, asking Buildbucket for the build status
[21:30:41.106] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:41.106] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:107:0) after 1m0s
[21:31:41.273] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:107:0)
[21:31:41.273] Timer tick, asking Buildbucket for the build status
[21:31:41.540] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:41.540] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:108:0) after 1m0s
[21:32:41.608] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:108:0)
[21:32:41.608] Timer tick, asking Buildbucket for the build status
[21:32:42.767] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:42.767] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:109:0) after 1m0s
[21:33:42.797] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:109:0)
[21:33:42.797] Timer tick, asking Buildbucket for the build status
[21:33:42.966] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:42.966] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:110:0) after 1m0s
[21:34:42.997] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:110:0)
[21:34:42.997] Timer tick, asking Buildbucket for the build status
[21:34:43.168] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:43.168] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:111:0) after 1m0s
[21:35:43.196] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:111:0)
[21:35:43.196] Timer tick, asking Buildbucket for the build status
[21:35:43.319] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:43.319] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:112:0) after 1m0s
[21:36:43.340] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:112:0)
[21:36:43.340] Timer tick, asking Buildbucket for the build status
[21:36:45.230] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:45.230] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:113:0) after 1m0s
[21:37:45.276] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:113:0)
[21:37:45.276] Timer tick, asking Buildbucket for the build status
[21:37:45.374] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:45.374] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:114:0) after 1m0s
[21:38:45.435] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:114:0)
[21:38:45.435] Timer tick, asking Buildbucket for the build status
[21:38:47.116] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:47.116] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:115:0) after 1m0s
[21:39:47.238] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:115:0)
[21:39:47.238] Timer tick, asking Buildbucket for the build status
[21:39:50.767] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:50.767] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:116:0) after 1m0s
[21:40:50.945] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:116:0)
[21:40:50.945] Timer tick, asking Buildbucket for the build status
[21:40:51.157] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:51.157] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:117:0) after 1m0s
[21:41:51.339] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:117:0)
[21:41:51.339] Timer tick, asking Buildbucket for the build status
[21:41:52.756] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:52.756] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:118:0) after 1m0s
[21:42:52.833] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:118:0)
[21:42:52.833] Timer tick, asking Buildbucket for the build status
[21:42:53.004] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:53.004] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:119:0) after 1m0s
[21:43:53.070] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:119:0)
[21:43:53.070] Timer tick, asking Buildbucket for the build status
[21:43:53.261] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:53.261] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:120:0) after 1m0s
[21:44:53.357] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:120:0)
[21:44:53.357] Timer tick, asking Buildbucket for the build status
[21:44:53.497] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:53.497] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:121:0) after 1m0s
[21:45:53.542] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:121:0)
[21:45:53.542] Timer tick, asking Buildbucket for the build status
[21:45:53.871] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:53.871] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:122:0) after 1m0s
[21:46:53.957] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:122:0)
[21:46:53.957] Timer tick, asking Buildbucket for the build status
[21:46:55.247] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:55.247] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:123:0) after 1m0s
[21:47:55.356] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:123:0)
[21:47:55.356] Timer tick, asking Buildbucket for the build status
[21:47:56.713] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:56.713] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:124:0) after 1m0s
[21:48:56.922] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:124:0)
[21:48:56.922] Timer tick, asking Buildbucket for the build status
[21:48:57.201] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:57.201] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:125:0) after 1m0s
[21:49:57.418] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:125:0)
[21:49:57.418] Timer tick, asking Buildbucket for the build status
[21:49:57.748] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:57.748] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:126:0) after 1m0s
[21:50:57.803] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:126:0)
[21:50:57.803] Timer tick, asking Buildbucket for the build status
[21:50:58.063] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:58.063] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:127:0) after 1m0s
[21:51:58.271] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:127:0)
[21:51:58.271] Timer tick, asking Buildbucket for the build status
[21:51:58.624] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:58.624] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:128:0) after 1m0s
[21:52:58.767] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:128:0)
[21:52:58.767] Timer tick, asking Buildbucket for the build status
[21:52:58.912] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:58.912] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:129:0) after 1m0s
[21:53:59.130] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:129:0)
[21:53:59.130] Timer tick, asking Buildbucket for the build status
[21:54:00.700] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:00.700] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:130:0) after 1m0s
[21:55:00.907] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:130:0)
[21:55:00.907] Timer tick, asking Buildbucket for the build status
[21:55:01.080] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:01.080] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:131:0) after 1m0s
[21:56:01.409] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:131:0)
[21:56:01.409] Timer tick, asking Buildbucket for the build status
[21:56:01.521] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:01.521] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:132:0) after 1m0s
[21:57:01.805] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:132:0)
[21:57:01.805] Timer tick, asking Buildbucket for the build status
[21:57:02.283] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:02.283] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:133:0) after 1m0s
[21:58:02.347] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:133:0)
[21:58:02.347] Timer tick, asking Buildbucket for the build status
[21:58:03.151] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:03.151] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:134:0) after 1m0s
[21:59:03.388] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:134:0)
[21:59:03.388] Timer tick, asking Buildbucket for the build status
[21:59:03.543] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:03.543] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:135:0) after 1m0s
[22:00:03.596] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:135:0)
[22:00:03.596] Timer tick, asking Buildbucket for the build status
[22:00:04.273] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:04.273] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:136:0) after 1m0s
[22:01:04.342] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:136:0)
[22:01:04.342] Timer tick, asking Buildbucket for the build status
[22:01:05.655] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:05.655] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:137:0) after 1m0s
[22:02:05.819] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:137:0)
[22:02:05.819] Timer tick, asking Buildbucket for the build status
[22:02:06.045] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:06.045] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:138:0) after 1m0s
[22:03:06.081] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:138:0)
[22:03:06.081] Timer tick, asking Buildbucket for the build status
[22:03:06.542] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:06.542] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:139:0) after 1m0s
[22:04:06.719] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:139:0)
[22:04:06.719] Timer tick, asking Buildbucket for the build status
[22:04:07.252] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:07.252] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:140:0) after 1m0s
[22:05:07.285] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:140:0)
[22:05:07.285] Timer tick, asking Buildbucket for the build status
[22:05:07.558] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:07.558] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:141:0) after 1m0s
[22:06:07.659] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:141:0)
[22:06:07.659] Timer tick, asking Buildbucket for the build status
[22:06:07.789] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:07.789] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:142:0) after 1m0s
[22:07:07.832] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:142:0)
[22:07:07.832] Timer tick, asking Buildbucket for the build status
[22:07:07.980] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:07.980] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:143:0) after 1m0s
[22:08:08.063] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:143:0)
[22:08:08.063] Timer tick, asking Buildbucket for the build status
[22:08:08.537] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:08.537] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:144:0) after 1m0s
[22:09:08.569] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:144:0)
[22:09:08.569] Timer tick, asking Buildbucket for the build status
[22:09:08.813] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:08.813] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:145:0) after 1m0s
[22:10:08.837] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:145:0)
[22:10:08.837] Timer tick, asking Buildbucket for the build status
[22:10:09.277] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:09.277] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:146:0) after 1m0s
[22:11:09.306] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:146:0)
[22:11:09.306] Timer tick, asking Buildbucket for the build status
[22:11:09.919] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:09.919] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:147:0) after 1m0s
[22:12:10.130] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:147:0)
[22:12:10.130] Timer tick, asking Buildbucket for the build status
[22:12:10.282] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:10.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:148:0) after 1m0s
[22:13:10.386] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:148:0)
[22:13:10.386] Timer tick, asking Buildbucket for the build status
[22:13:12.050] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:12.050] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:149:0) after 1m0s
[22:14:12.125] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:149:0)
[22:14:12.125] Timer tick, asking Buildbucket for the build status
[22:14:12.286] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:12.286] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:150:0) after 1m0s
[22:15:12.284] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:150:0)
[22:15:12.284] Timer tick, asking Buildbucket for the build status
[22:15:12.535] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:12.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:151:0) after 1m0s
[22:16:12.591] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:151:0)
[22:16:12.591] Timer tick, asking Buildbucket for the build status
[22:16:12.710] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:12.710] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:152:0) after 1m0s
[22:17:12.725] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:152:0)
[22:17:12.725] Timer tick, asking Buildbucket for the build status
[22:17:12.849] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:12.849] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:153:0) after 1m0s
[22:18:12.881] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:153:0)
[22:18:12.881] Timer tick, asking Buildbucket for the build status
[22:18:13.200] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:13.200] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:154:0) after 1m0s
[22:19:13.296] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:154:0)
[22:19:13.296] Timer tick, asking Buildbucket for the build status
[22:19:13.933] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:13.933] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:155:0) after 1m0s
[22:20:13.983] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:155:0)
[22:20:13.983] Timer tick, asking Buildbucket for the build status
[22:20:14.096] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:14.096] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:156:0) after 1m0s
[22:21:14.443] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:156:0)
[22:21:14.443] Timer tick, asking Buildbucket for the build status
[22:21:14.739] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:14.740] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:157:0) after 1m0s
[22:22:15.241] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:157:0)
[22:22:15.241] Timer tick, asking Buildbucket for the build status
[22:22:15.496] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:15.496] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:158:0) after 1m0s
[22:23:15.685] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:158:0)
[22:23:15.685] Timer tick, asking Buildbucket for the build status
[22:23:16.956] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:16.956] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:159:0) after 1m0s
[22:24:16.964] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:159:0)
[22:24:16.964] Timer tick, asking Buildbucket for the build status
[22:24:18.418] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:18.418] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:160:0) after 1m0s
[22:25:18.433] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:160:0)
[22:25:18.433] Timer tick, asking Buildbucket for the build status
[22:25:18.568] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:18.568] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:161:0) after 1m0s
[22:26:18.602] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:161:0)
[22:26:18.602] Timer tick, asking Buildbucket for the build status
[22:26:19.019] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:19.019] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:162:0) after 1m0s
[22:27:19.048] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:162:0)
[22:27:19.048] Timer tick, asking Buildbucket for the build status
[22:27:19.294] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:19.294] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:163:0) after 1m0s
[22:28:19.336] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:163:0)
[22:28:19.337] Timer tick, asking Buildbucket for the build status
[22:28:19.465] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:19.465] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:164:0) after 1m0s
[22:29:19.525] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:164:0)
[22:29:19.525] Timer tick, asking Buildbucket for the build status
[22:29:19.741] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:19.742] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:165:0) after 1m0s
[22:30:19.751] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:165:0)
[22:30:19.751] Timer tick, asking Buildbucket for the build status
[22:30:20.207] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:20.207] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:166:0) after 1m0s
[22:31:20.281] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:166:0)
[22:31:20.281] Timer tick, asking Buildbucket for the build status
[22:31:20.453] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:20.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:167:0) after 1m0s
[22:32:20.520] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:167:0)
[22:32:20.521] Timer tick, asking Buildbucket for the build status
[22:32:20.973] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:20.973] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:168:0) after 1m0s
[22:33:21.066] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:168:0)
[22:33:21.066] Timer tick, asking Buildbucket for the build status
[22:33:21.456] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:21.456] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:169:0) after 1m0s
[22:34:21.471] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:169:0)
[22:34:21.471] Timer tick, asking Buildbucket for the build status
[22:34:21.566] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:21.566] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:170:0) after 1m0s
[22:35:21.625] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:170:0)
[22:35:21.625] Timer tick, asking Buildbucket for the build status
[22:35:21.791] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:21.791] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:171:0) after 1m0s
[22:36:21.822] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:171:0)
[22:36:21.822] Timer tick, asking Buildbucket for the build status
[22:36:21.919] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:21.919] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:172:0) after 1m0s
[22:37:22.055] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:172:0)
[22:37:22.055] Timer tick, asking Buildbucket for the build status
[22:37:22.314] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:22.314] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:173:0) after 1m0s
[22:38:22.538] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:173:0)
[22:38:22.538] Timer tick, asking Buildbucket for the build status
[22:38:23.396] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:23.396] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:174:0) after 1m0s
[22:39:23.516] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:174:0)
[22:39:23.516] Timer tick, asking Buildbucket for the build status
[22:39:25.007] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:25.007] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:175:0) after 1m0s
[22:40:25.029] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:175:0)
[22:40:25.029] Timer tick, asking Buildbucket for the build status
[22:40:25.308] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:25.308] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:176:0) after 1m0s
[22:41:25.340] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:176:0)
[22:41:25.340] Timer tick, asking Buildbucket for the build status
[22:41:25.640] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:25.640] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:177:0) after 1m0s
[22:42:25.703] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:177:0)
[22:42:25.703] Timer tick, asking Buildbucket for the build status
[22:42:25.890] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:25.890] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:178:0) after 1m0s
[22:43:26.023] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:178:0)
[22:43:26.023] Timer tick, asking Buildbucket for the build status
[22:43:26.316] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:26.316] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:179:0) after 1m0s
[22:44:26.417] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:179:0)
[22:44:26.417] Timer tick, asking Buildbucket for the build status
[22:44:28.696] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:28.696] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:180:0) after 1m0s
[22:45:28.737] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:180:0)
[22:45:28.737] Timer tick, asking Buildbucket for the build status
[22:45:28.895] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:28.895] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:181:0) after 1m0s
[22:46:28.940] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:181:0)
[22:46:28.940] Timer tick, asking Buildbucket for the build status
[22:46:29.315] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:29.315] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:182:0) after 1m0s
[22:47:29.342] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:182:0)
[22:47:29.342] Timer tick, asking Buildbucket for the build status
[22:47:29.628] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:29.628] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:183:0) after 1m0s
[22:48:29.651] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:183:0)
[22:48:29.651] Timer tick, asking Buildbucket for the build status
[22:48:29.796] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:29.796] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:184:0) after 1m0s
[22:49:29.883] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:184:0)
[22:49:29.883] Timer tick, asking Buildbucket for the build status
[22:49:30.009] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:30.009] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:185:0) after 1m0s
[22:50:30.047] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:185:0)
[22:50:30.047] Timer tick, asking Buildbucket for the build status
[22:50:30.212] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:30.212] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:186:0) after 1m0s
[22:51:30.199] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:186:0)
[22:51:30.199] Timer tick, asking Buildbucket for the build status
[22:51:30.381] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:30.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:187:0) after 1m0s
[22:52:30.690] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:187:0)
[22:52:30.690] Timer tick, asking Buildbucket for the build status
[22:52:31.103] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:31.103] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:188:0) after 1m0s
[22:53:31.287] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:188:0)
[22:53:31.287] Timer tick, asking Buildbucket for the build status
[22:53:31.612] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:31.612] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:189:0) after 1m0s
[22:54:31.661] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:189:0)
[22:54:31.661] Timer tick, asking Buildbucket for the build status
[22:54:32.153] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:32.153] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:190:0) after 1m0s
[22:55:32.215] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:190:0)
[22:55:32.215] Timer tick, asking Buildbucket for the build status
[22:55:33.628] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:33.628] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:191:0) after 1m0s
[22:56:33.690] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:191:0)
[22:56:33.690] Timer tick, asking Buildbucket for the build status
[22:56:33.793] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:33.793] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:192:0) after 1m0s
[22:57:33.795] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:192:0)
[22:57:33.795] Timer tick, asking Buildbucket for the build status
[22:57:33.989] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:33.989] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:193:0) after 1m0s
[22:58:34.053] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:193:0)
[22:58:34.053] Timer tick, asking Buildbucket for the build status
[22:58:34.161] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:34.161] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:194:0) after 1m0s
[22:59:34.289] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:194:0)
[22:59:34.289] Timer tick, asking Buildbucket for the build status
[22:59:34.505] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:34.505] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:195:0) after 1m0s
[23:00:34.555] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:195:0)
[23:00:34.555] Timer tick, asking Buildbucket for the build status
[23:00:34.977] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:34.977] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:196:0) after 1m0s
[23:01:35.005] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:196:0)
[23:01:35.006] Timer tick, asking Buildbucket for the build status
[23:01:35.193] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:35.193] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:197:0) after 1m0s
[23:02:35.238] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:197:0)
[23:02:35.238] Timer tick, asking Buildbucket for the build status
[23:02:35.519] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:35.519] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:198:0) after 1m0s
[23:03:35.563] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:198:0)
[23:03:35.563] Timer tick, asking Buildbucket for the build status
[23:03:35.706] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:35.706] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:199:0) after 1m0s
[23:04:35.867] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:199:0)
[23:04:35.867] Timer tick, asking Buildbucket for the build status
[23:04:36.016] Build 8907204629748996160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:36.016] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9072634691824112112:200:0) after 1m0s
[23:05:01.785] Received PubSub notification, asking Buildbucket for the build status
[23:05:01.862] Build 8907204629748996160: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:05:01.862] Buildbucket build:
{
  "build": {
    "bucket": "luci.r8.ci",
    "canary_preference": "PROD",
    "completed_ts": "1563836700929324",
    "created_by": "project:r8",
    "created_ts": "1563824735841963",
    "id": "8907204629748996160",
    "parameters_json": "{\"builder_name\": \"linux-internal\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"e8af15654c1f7b68d802722ddc919e7db3c75cfb\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@e8af15654c1f7b68d802722ddc919e7db3c75cfb\", \"title\": \"e8af15654c1f7b68d802722ddc919e7db3c75cfb\", \"url\": \"https://r8.googlesource.com/r8/+/e8af15654c1f7b68d802722ddc919e7db3c75cfb\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"e8af15654c1f7b68d802722ddc919e7db3c75cfb\"}}",
    "project": "r8",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"e8af15654c1f7b68d802722ddc919e7db3c75cfb\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@e8af15654c1f7b68d802722ddc919e7db3c75cfb\", \"title\": \"e8af15654c1f7b68d802722ddc919e7db3c75cfb\", \"url\": \"https://r8.googlesource.com/r8/+/e8af15654c1f7b68d802722ddc919e7db3c75cfb\"}]}, \"bot_id\": \"luci-r8-ci-internal-0-ac66\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-internal\", \"buildnumber\": 434, \"internal\": \"True\", \"mastername\": \"internal.client.r8\", \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"e8af15654c1f7b68d802722ddc919e7db3c75cfb\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-r8-ci-internal-0-ac66\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"internal\": [\"true\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.r8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4370-0e704a3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1563824740894838",
    "status": "COMPLETED",
    "status_changed_ts": "1563836701300518",
    "tags": [
      "build_address:luci.r8.ci/linux-internal/434",
      "builder:linux-internal",
      "buildset:commit/git/e8af15654c1f7b68d802722ddc919e7db3c75cfb",
      "buildset:commit/gitiles/r8.googlesource.com/r8/+/e8af15654c1f7b68d802722ddc919e7db3c75cfb",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9072634691824112112",
      "scheduler_job_id:r8/linux-internal",
      "swarming_hostname:chrome-swarming.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/r8/buildbucket/cr-buildbucket.appspot.com/8907204629748996160/+/annotations",
      "swarming_tag:luci_project:r8",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:rex",
      "swarming_tag:recipe_package:infra_internal/recipe_bundles/chrome-internal.googlesource.com/chrome/tools/build_limited/scripts/slave",
      "swarming_task_id:463409547516f010",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1563836701318902",
    "url": "https://ci.chromium.org/b/8907204629748996160",
    "utcnow_ts": "1563836701852855"
  }
}
[23:05:01.862] Invocation finished in 3h19m27.383426861s with status SUCCEEDED