[09:28:38.800] New invocation is queued and will start shortly
[09:28:39.880] Starting the invocation (attempt 1)
[09:28:39.955] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:28:39.955] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:28:39.955] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9071223954144525376",
"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\":\"201247876dd199d1fa464d5986383d1d5ff057a9\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@201247876dd199d1fa464d5986383d1d5ff057a9\",\"title\":\"201247876dd199d1fa464d5986383d1d5ff057a9\",\"url\":\"https://r8.googlesource.com/r8/+/201247876dd199d1fa464d5986383d1d5ff057a9\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"201247876dd199d1fa464d5986383d1d5ff057a9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-internal",
"scheduler_invocation_id:9071223954144525376",
"scheduler_job_id:r8/linux-internal",
"user_agent:luci-scheduler",
"buildset:commit/git/201247876dd199d1fa464d5986383d1d5ff057a9",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/201247876dd199d1fa464d5986383d1d5ff057a9",
"gitiles_ref:refs/heads/master"
]
}
[09:28:41.093] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1565170120083994",
"id": "8905793892122521712",
"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\": \"201247876dd199d1fa464d5986383d1d5ff057a9\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@201247876dd199d1fa464d5986383d1d5ff057a9\", \"title\": \"201247876dd199d1fa464d5986383d1d5ff057a9\", \"url\": \"https://r8.googlesource.com/r8/+/201247876dd199d1fa464d5986383d1d5ff057a9\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"201247876dd199d1fa464d5986383d1d5ff057a9\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565170120748537",
"tags": [
"build_address:luci.r8.ci/linux-internal/475",
"builder:linux-internal",
"buildset:commit/git/201247876dd199d1fa464d5986383d1d5ff057a9",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/201247876dd199d1fa464d5986383d1d5ff057a9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071223954144525376",
"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/8905793892122521712/+/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": "1565170120748653",
"url": "https://ci.chromium.org/b/8905793892122521712",
"utcnow_ts": "1565170121081350"
}
}
[09:28:41.093] Task URL: https://ci.chromium.org/b/8905793892122521712
[09:28:41.093] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:2:0) after 1m0s
[09:28:45.406] Received PubSub notification, asking Buildbucket for the build status
[09:28:45.600] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:41.184] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:2:0)
[09:29:41.184] Timer tick, asking Buildbucket for the build status
[09:29:42.890] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:42.890] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:4:0) after 1m0s
[09:30:42.914] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:4:0)
[09:30:42.915] Timer tick, asking Buildbucket for the build status
[09:30:43.017] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:43.017] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:5:0) after 1m0s
[09:31:43.039] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:5:0)
[09:31:43.039] Timer tick, asking Buildbucket for the build status
[09:31:43.473] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:43.473] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:6:0) after 1m0s
[09:32:43.530] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:6:0)
[09:32:43.530] Timer tick, asking Buildbucket for the build status
[09:32:44.213] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:44.214] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:7:0) after 1m0s
[09:33:44.298] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:7:0)
[09:33:44.298] Timer tick, asking Buildbucket for the build status
[09:33:44.498] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:44.498] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:8:0) after 1m0s
[09:34:44.639] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:8:0)
[09:34:44.639] Timer tick, asking Buildbucket for the build status
[09:34:44.765] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:44.765] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:9:0) after 1m0s
[09:35:44.847] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:9:0)
[09:35:44.847] Timer tick, asking Buildbucket for the build status
[09:35:44.977] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:44.977] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:10:0) after 1m0s
[09:36:45.030] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:10:0)
[09:36:45.030] Timer tick, asking Buildbucket for the build status
[09:36:45.214] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:45.214] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:11:0) after 1m0s
[09:37:45.237] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:11:0)
[09:37:45.237] Timer tick, asking Buildbucket for the build status
[09:37:46.153] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:46.153] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:12:0) after 1m0s
[09:38:46.383] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:12:0)
[09:38:46.383] Timer tick, asking Buildbucket for the build status
[09:38:46.535] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:46.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:13:0) after 1m0s
[09:39:46.625] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:13:0)
[09:39:46.625] Timer tick, asking Buildbucket for the build status
[09:39:46.725] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:46.725] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:14:0) after 1m0s
[09:40:46.806] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:14:0)
[09:40:46.806] Timer tick, asking Buildbucket for the build status
[09:40:47.231] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:47.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:15:0) after 1m0s
[09:41:47.398] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:15:0)
[09:41:47.398] Timer tick, asking Buildbucket for the build status
[09:41:48.280] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:48.280] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:16:0) after 1m0s
[09:42:48.326] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:16:0)
[09:42:48.326] Timer tick, asking Buildbucket for the build status
[09:42:48.680] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:48.680] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:17:0) after 1m0s
[09:43:48.740] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:17:0)
[09:43:48.740] Timer tick, asking Buildbucket for the build status
[09:43:49.430] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:49.430] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:18:0) after 1m0s
[09:44:49.454] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:18:0)
[09:44:49.454] Timer tick, asking Buildbucket for the build status
[09:44:51.604] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:51.604] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:19:0) after 1m0s
[09:45:51.609] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:19:0)
[09:45:51.609] Timer tick, asking Buildbucket for the build status
[09:45:52.152] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:52.152] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:20:0) after 1m0s
[09:46:52.173] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:20:0)
[09:46:52.173] Timer tick, asking Buildbucket for the build status
[09:46:52.666] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:52.666] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:21:0) after 1m0s
[09:47:52.695] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:21:0)
[09:47:52.695] Timer tick, asking Buildbucket for the build status
[09:47:53.157] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:53.157] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:22:0) after 1m0s
[09:48:53.174] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:22:0)
[09:48:53.174] Timer tick, asking Buildbucket for the build status
[09:48:53.352] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:53.352] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:23:0) after 1m0s
[09:49:53.374] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:23:0)
[09:49:53.374] Timer tick, asking Buildbucket for the build status
[09:49:54.121] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:54.121] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:24:0) after 1m0s
[09:50:54.170] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:24:0)
[09:50:54.170] Timer tick, asking Buildbucket for the build status
[09:50:54.372] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:54.372] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:25:0) after 1m0s
[09:51:54.395] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:25:0)
[09:51:54.397] Timer tick, asking Buildbucket for the build status
[09:51:54.683] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:54.683] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:26:0) after 1m0s
[09:52:54.821] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:26:0)
[09:52:54.821] Timer tick, asking Buildbucket for the build status
[09:52:55.473] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:55.473] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:27:0) after 1m0s
[09:53:55.837] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:27:0)
[09:53:55.837] Timer tick, asking Buildbucket for the build status
[09:53:55.999] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:55.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:28:0) after 1m0s
[09:54:56.228] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:28:0)
[09:54:56.228] Timer tick, asking Buildbucket for the build status
[09:54:56.405] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:56.405] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:29:0) after 1m0s
[09:55:56.557] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:29:0)
[09:55:56.557] Timer tick, asking Buildbucket for the build status
[09:55:56.731] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:56.731] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:30:0) after 1m0s
[09:56:56.976] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:30:0)
[09:56:56.976] Timer tick, asking Buildbucket for the build status
[09:56:57.604] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:57.604] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:31:0) after 1m0s
[09:57:57.712] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:31:0)
[09:57:57.712] Timer tick, asking Buildbucket for the build status
[09:57:57.827] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:57.827] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:32:0) after 1m0s
[09:58:57.975] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:32:0)
[09:58:57.975] Timer tick, asking Buildbucket for the build status
[09:58:58.369] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:58.369] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:33:0) after 1m0s
[09:59:58.410] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:33:0)
[09:59:58.410] Timer tick, asking Buildbucket for the build status
[09:59:58.585] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:58.585] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:34:0) after 1m0s
[10:00:58.609] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:34:0)
[10:00:58.609] Timer tick, asking Buildbucket for the build status
[10:00:58.842] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:58.842] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:35:0) after 1m0s
[10:01:59.046] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:35:0)
[10:01:59.046] Timer tick, asking Buildbucket for the build status
[10:01:59.296] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:59.296] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:36:0) after 1m0s
[10:02:59.605] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:36:0)
[10:02:59.605] Timer tick, asking Buildbucket for the build status
[10:02:59.976] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:59.976] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:37:0) after 1m0s
[10:04:00.168] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:37:0)
[10:04:00.168] Timer tick, asking Buildbucket for the build status
[10:04:00.343] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:00.343] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:38:0) after 1m0s
[10:05:00.420] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:38:0)
[10:05:00.420] Timer tick, asking Buildbucket for the build status
[10:05:02.463] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:02.463] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:39:0) after 1m0s
[10:06:02.546] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:39:0)
[10:06:02.546] Timer tick, asking Buildbucket for the build status
[10:06:02.812] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:02.812] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:40:0) after 1m0s
[10:07:02.852] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:40:0)
[10:07:02.852] Timer tick, asking Buildbucket for the build status
[10:07:02.954] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:02.954] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:41:0) after 1m0s
[10:08:03.985] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:41:0)
[10:08:03.985] Timer tick, asking Buildbucket for the build status
[10:08:04.260] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:04.260] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:42:0) after 1m0s
[10:09:04.491] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:42:0)
[10:09:04.491] Timer tick, asking Buildbucket for the build status
[10:09:04.577] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:04.577] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:43:0) after 1m0s
[10:10:05.202] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:43:0)
[10:10:05.202] Timer tick, asking Buildbucket for the build status
[10:10:05.381] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:05.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:44:0) after 1m0s
[10:11:05.748] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:44:0)
[10:11:05.748] Timer tick, asking Buildbucket for the build status
[10:11:05.842] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:05.842] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:45:0) after 1m0s
[10:12:05.849] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:45:0)
[10:12:05.849] Timer tick, asking Buildbucket for the build status
[10:12:06.187] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:06.187] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:46:0) after 1m0s
[10:13:06.239] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:46:0)
[10:13:06.239] Timer tick, asking Buildbucket for the build status
[10:13:07.091] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:07.091] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:47:0) after 1m0s
[10:14:07.276] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:47:0)
[10:14:07.276] Timer tick, asking Buildbucket for the build status
[10:14:07.501] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:07.501] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:48:0) after 1m0s
[10:15:07.571] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:48:0)
[10:15:07.571] Timer tick, asking Buildbucket for the build status
[10:15:07.843] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:07.843] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:49:0) after 1m0s
[10:16:07.822] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:49:0)
[10:16:07.822] Timer tick, asking Buildbucket for the build status
[10:16:07.987] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:07.987] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:50:0) after 1m0s
[10:17:08.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:50:0)
[10:17:08.113] Timer tick, asking Buildbucket for the build status
[10:17:08.485] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:08.485] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:51:0) after 1m0s
[10:18:08.510] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:51:0)
[10:18:08.510] Timer tick, asking Buildbucket for the build status
[10:18:08.692] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:08.692] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:52:0) after 1m0s
[10:19:08.766] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:52:0)
[10:19:08.766] Timer tick, asking Buildbucket for the build status
[10:19:09.075] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:09.075] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:53:0) after 1m0s
[10:20:09.148] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:53:0)
[10:20:09.148] Timer tick, asking Buildbucket for the build status
[10:20:09.617] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:09.617] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:54:0) after 1m0s
[10:21:09.645] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:54:0)
[10:21:09.645] Timer tick, asking Buildbucket for the build status
[10:21:10.929] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:10.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:55:0) after 1m0s
[10:22:10.945] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:55:0)
[10:22:10.945] Timer tick, asking Buildbucket for the build status
[10:22:11.514] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:11.514] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:56:0) after 1m0s
[10:23:11.606] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:56:0)
[10:23:11.606] Timer tick, asking Buildbucket for the build status
[10:23:11.777] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:11.777] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:57:0) after 1m0s
[10:24:11.844] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:57:0)
[10:24:11.844] Timer tick, asking Buildbucket for the build status
[10:24:12.103] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:12.103] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:58:0) after 1m0s
[10:25:12.128] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:58:0)
[10:25:12.128] Timer tick, asking Buildbucket for the build status
[10:25:12.239] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:12.239] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:59:0) after 1m0s
[10:26:12.273] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:59:0)
[10:26:12.273] Timer tick, asking Buildbucket for the build status
[10:26:12.458] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:12.458] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:60:0) after 1m0s
[10:27:12.526] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:60:0)
[10:27:12.526] Timer tick, asking Buildbucket for the build status
[10:27:12.784] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:12.784] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:61:0) after 1m0s
[10:28:12.800] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:61:0)
[10:28:12.800] Timer tick, asking Buildbucket for the build status
[10:28:13.056] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:13.057] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:62:0) after 1m0s
[10:29:13.088] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:62:0)
[10:29:13.088] Timer tick, asking Buildbucket for the build status
[10:29:13.568] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:13.568] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:63:0) after 1m0s
[10:30:13.599] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:63:0)
[10:30:13.599] Timer tick, asking Buildbucket for the build status
[10:30:14.719] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:14.719] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:64:0) after 1m0s
[10:31:14.747] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:64:0)
[10:31:14.747] Timer tick, asking Buildbucket for the build status
[10:31:14.882] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:14.882] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:65:0) after 1m0s
[10:32:14.905] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:65:0)
[10:32:14.905] Timer tick, asking Buildbucket for the build status
[10:32:15.511] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:15.511] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:66:0) after 1m0s
[10:33:15.602] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:66:0)
[10:33:15.602] Timer tick, asking Buildbucket for the build status
[10:33:15.866] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:15.866] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:67:0) after 1m0s
[10:34:15.930] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:67:0)
[10:34:15.930] Timer tick, asking Buildbucket for the build status
[10:34:16.122] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:16.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:68:0) after 1m0s
[10:35:16.229] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:68:0)
[10:35:16.229] Timer tick, asking Buildbucket for the build status
[10:35:16.519] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:16.519] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:69:0) after 1m0s
[10:36:16.603] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:69:0)
[10:36:16.603] Timer tick, asking Buildbucket for the build status
[10:36:16.832] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:16.832] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:70:0) after 1m0s
[10:37:16.851] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:70:0)
[10:37:16.851] Timer tick, asking Buildbucket for the build status
[10:37:16.997] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:16.997] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:71:0) after 1m0s
[10:38:17.246] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:71:0)
[10:38:17.247] Timer tick, asking Buildbucket for the build status
[10:38:17.448] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:17.448] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:72:0) after 1m0s
[10:39:17.479] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:72:0)
[10:39:17.479] Timer tick, asking Buildbucket for the build status
[10:39:18.283] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:18.283] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:73:0) after 1m0s
[10:40:18.408] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:73:0)
[10:40:18.408] Timer tick, asking Buildbucket for the build status
[10:40:18.579] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:18.579] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:74:0) after 1m0s
[10:41:18.653] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:74:0)
[10:41:18.653] Timer tick, asking Buildbucket for the build status
[10:41:18.848] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:18.848] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:75:0) after 1m0s
[10:42:18.911] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:75:0)
[10:42:18.911] Timer tick, asking Buildbucket for the build status
[10:42:19.335] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:19.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:76:0) after 1m0s
[10:43:19.418] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:76:0)
[10:43:19.418] Timer tick, asking Buildbucket for the build status
[10:43:19.522] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:19.523] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:77:0) after 1m0s
[10:44:19.596] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:77:0)
[10:44:19.596] Timer tick, asking Buildbucket for the build status
[10:44:19.848] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:19.849] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:78:0) after 1m0s
[10:45:19.945] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:78:0)
[10:45:19.945] Timer tick, asking Buildbucket for the build status
[10:45:20.169] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:20.169] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:79:0) after 1m0s
[10:46:20.292] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:79:0)
[10:46:20.292] Timer tick, asking Buildbucket for the build status
[10:46:20.696] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:20.696] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:80:0) after 1m0s
[10:47:20.753] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:80:0)
[10:47:20.753] Timer tick, asking Buildbucket for the build status
[10:47:20.900] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:20.900] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:81:0) after 1m0s
[10:48:20.948] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:81:0)
[10:48:20.948] Timer tick, asking Buildbucket for the build status
[10:48:21.137] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:21.137] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:82:0) after 1m0s
[10:49:21.193] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:82:0)
[10:49:21.193] Timer tick, asking Buildbucket for the build status
[10:49:21.489] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:21.489] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:83:0) after 1m0s
[10:50:21.544] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:83:0)
[10:50:21.544] Timer tick, asking Buildbucket for the build status
[10:50:21.781] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:21.782] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:84:0) after 1m0s
[10:51:21.920] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:84:0)
[10:51:21.920] Timer tick, asking Buildbucket for the build status
[10:51:22.616] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:22.616] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:85:0) after 1m0s
[10:52:22.645] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:85:0)
[10:52:22.645] Timer tick, asking Buildbucket for the build status
[10:52:22.740] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:22.740] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:86:0) after 1m0s
[10:53:22.775] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:86:0)
[10:53:22.775] Timer tick, asking Buildbucket for the build status
[10:53:23.786] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:23.786] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:87:0) after 1m0s
[10:54:23.812] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:87:0)
[10:54:23.812] Timer tick, asking Buildbucket for the build status
[10:54:24.204] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:24.204] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:88:0) after 1m0s
[10:55:24.315] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:88:0)
[10:55:24.315] Timer tick, asking Buildbucket for the build status
[10:55:24.491] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:24.491] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:89:0) after 1m0s
[10:56:24.667] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:89:0)
[10:56:24.667] Timer tick, asking Buildbucket for the build status
[10:56:24.918] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:24.918] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:90:0) after 1m0s
[10:57:24.948] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:90:0)
[10:57:24.948] Timer tick, asking Buildbucket for the build status
[10:57:25.429] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:25.429] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:91:0) after 1m0s
[10:58:25.511] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:91:0)
[10:58:25.511] Timer tick, asking Buildbucket for the build status
[10:58:25.615] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:25.615] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:92:0) after 1m0s
[10:59:25.711] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:92:0)
[10:59:25.711] Timer tick, asking Buildbucket for the build status
[10:59:26.039] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:26.040] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:93:0) after 1m0s
[11:00:26.059] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:93:0)
[11:00:26.059] Timer tick, asking Buildbucket for the build status
[11:00:26.264] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:26.264] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:94:0) after 1m0s
[11:01:26.454] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:94:0)
[11:01:26.454] Timer tick, asking Buildbucket for the build status
[11:01:26.654] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:26.655] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:95:0) after 1m0s
[11:02:26.755] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:95:0)
[11:02:26.755] Timer tick, asking Buildbucket for the build status
[11:02:26.879] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:26.879] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:96:0) after 1m0s
[11:03:27.024] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:96:0)
[11:03:27.024] Timer tick, asking Buildbucket for the build status
[11:03:27.493] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:27.493] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:97:0) after 1m0s
[11:04:27.650] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:97:0)
[11:04:27.650] Timer tick, asking Buildbucket for the build status
[11:04:29.713] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:29.713] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:98:0) after 1m0s
[11:05:29.885] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:98:0)
[11:05:29.885] Timer tick, asking Buildbucket for the build status
[11:05:30.686] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:30.686] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:99:0) after 1m0s
[11:06:30.846] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:99:0)
[11:06:30.846] Timer tick, asking Buildbucket for the build status
[11:06:31.237] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:31.237] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:100:0) after 1m0s
[11:07:31.247] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:100:0)
[11:07:31.247] Timer tick, asking Buildbucket for the build status
[11:07:31.662] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:31.662] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:101:0) after 1m0s
[11:08:31.904] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:101:0)
[11:08:31.904] Timer tick, asking Buildbucket for the build status
[11:08:32.175] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:32.175] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:102:0) after 1m0s
[11:09:32.224] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:102:0)
[11:09:32.224] Timer tick, asking Buildbucket for the build status
[11:09:32.551] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:32.551] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:103:0) after 1m0s
[11:10:32.647] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:103:0)
[11:10:32.647] Timer tick, asking Buildbucket for the build status
[11:10:33.059] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:33.059] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:104:0) after 1m0s
[11:11:33.164] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:104:0)
[11:11:33.164] Timer tick, asking Buildbucket for the build status
[11:11:33.511] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:33.511] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:105:0) after 1m0s
[11:12:33.569] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:105:0)
[11:12:33.569] Timer tick, asking Buildbucket for the build status
[11:12:33.816] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:33.816] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:106:0) after 1m0s
[11:13:33.841] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:106:0)
[11:13:33.841] Timer tick, asking Buildbucket for the build status
[11:13:33.943] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:33.943] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:107:0) after 1m0s
[11:14:34.022] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:107:0)
[11:14:34.022] Timer tick, asking Buildbucket for the build status
[11:14:34.391] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:34.391] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:108:0) after 1m0s
[11:15:34.434] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:108:0)
[11:15:34.434] Timer tick, asking Buildbucket for the build status
[11:15:35.188] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:35.188] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:109:0) after 1m0s
[11:16:35.257] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:109:0)
[11:16:35.257] Timer tick, asking Buildbucket for the build status
[11:16:35.453] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:35.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:110:0) after 1m0s
[11:17:35.473] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:110:0)
[11:17:35.473] Timer tick, asking Buildbucket for the build status
[11:17:35.733] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:35.733] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:111:0) after 1m0s
[11:18:35.883] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:111:0)
[11:18:35.883] Timer tick, asking Buildbucket for the build status
[11:18:35.992] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:35.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:112:0) after 1m0s
[11:19:36.037] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:112:0)
[11:19:36.037] Timer tick, asking Buildbucket for the build status
[11:19:36.163] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:36.163] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:113:0) after 1m0s
[11:20:36.202] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:113:0)
[11:20:36.202] Timer tick, asking Buildbucket for the build status
[11:20:36.394] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:36.394] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:114:0) after 1m0s
[11:21:36.514] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:114:0)
[11:21:36.514] Timer tick, asking Buildbucket for the build status
[11:21:36.632] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:36.632] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:115:0) after 1m0s
[11:22:36.679] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:115:0)
[11:22:36.679] Timer tick, asking Buildbucket for the build status
[11:22:36.846] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:36.846] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:116:0) after 1m0s
[11:23:36.991] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:116:0)
[11:23:36.991] Timer tick, asking Buildbucket for the build status
[11:23:37.373] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:37.373] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:117:0) after 1m0s
[11:24:37.376] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:117:0)
[11:24:37.376] Timer tick, asking Buildbucket for the build status
[11:24:37.889] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:37.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:118:0) after 1m0s
[11:25:38.013] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:118:0)
[11:25:38.013] Timer tick, asking Buildbucket for the build status
[11:25:38.417] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:38.417] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:119:0) after 1m0s
[11:26:38.514] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:119:0)
[11:26:38.514] Timer tick, asking Buildbucket for the build status
[11:26:38.737] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:38.737] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:120:0) after 1m0s
[11:27:38.790] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:120:0)
[11:27:38.790] Timer tick, asking Buildbucket for the build status
[11:27:39.004] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:39.004] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:121:0) after 1m0s
[11:28:39.088] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:121:0)
[11:28:39.088] Timer tick, asking Buildbucket for the build status
[11:28:39.895] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:39.895] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:122:0) after 1m0s
[11:29:39.932] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:122:0)
[11:29:39.932] Timer tick, asking Buildbucket for the build status
[11:29:40.112] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:40.113] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:123:0) after 1m0s
[11:30:40.140] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:123:0)
[11:30:40.140] Timer tick, asking Buildbucket for the build status
[11:30:40.285] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:40.285] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:124:0) after 1m0s
[11:31:40.354] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:124:0)
[11:31:40.354] Timer tick, asking Buildbucket for the build status
[11:31:40.672] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:40.672] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:125:0) after 1m0s
[11:32:40.700] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:125:0)
[11:32:40.700] Timer tick, asking Buildbucket for the build status
[11:32:40.832] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:40.832] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:126:0) after 1m0s
[11:33:40.914] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:126:0)
[11:33:40.914] Timer tick, asking Buildbucket for the build status
[11:33:41.163] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:41.163] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:127:0) after 1m0s
[11:34:41.203] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:127:0)
[11:34:41.203] Timer tick, asking Buildbucket for the build status
[11:34:41.669] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:41.669] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:128:0) after 1m0s
[11:35:41.687] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:128:0)
[11:35:41.687] Timer tick, asking Buildbucket for the build status
[11:35:42.098] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:42.098] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:129:0) after 1m0s
[11:36:42.140] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:129:0)
[11:36:42.140] Timer tick, asking Buildbucket for the build status
[11:36:42.359] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:42.359] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:130:0) after 1m0s
[11:37:42.402] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:130:0)
[11:37:42.402] Timer tick, asking Buildbucket for the build status
[11:37:42.853] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:42.853] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:131:0) after 1m0s
[11:38:42.895] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:131:0)
[11:38:42.895] Timer tick, asking Buildbucket for the build status
[11:38:43.115] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:43.115] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:132:0) after 1m0s
[11:39:43.145] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:132:0)
[11:39:43.145] Timer tick, asking Buildbucket for the build status
[11:39:43.257] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:43.257] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:133:0) after 1m0s
[11:40:43.308] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:133:0)
[11:40:43.308] Timer tick, asking Buildbucket for the build status
[11:40:44.056] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:44.056] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:134:0) after 1m0s
[11:41:44.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:134:0)
[11:41:44.113] Timer tick, asking Buildbucket for the build status
[11:41:44.415] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:44.415] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:135:0) after 1m0s
[11:42:44.514] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:135:0)
[11:42:44.514] Timer tick, asking Buildbucket for the build status
[11:42:44.992] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:44.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:136:0) after 1m0s
[11:43:45.099] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:136:0)
[11:43:45.099] Timer tick, asking Buildbucket for the build status
[11:43:46.425] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:46.425] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:137:0) after 1m0s
[11:44:46.545] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:137:0)
[11:44:46.545] Timer tick, asking Buildbucket for the build status
[11:44:46.735] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:46.735] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:138:0) after 1m0s
[11:45:46.766] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:138:0)
[11:45:46.766] Timer tick, asking Buildbucket for the build status
[11:45:46.939] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:46.939] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:139:0) after 1m0s
[11:46:46.994] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:139:0)
[11:46:46.994] Timer tick, asking Buildbucket for the build status
[11:46:47.207] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:47.207] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:140:0) after 1m0s
[11:47:47.277] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:140:0)
[11:47:47.277] Timer tick, asking Buildbucket for the build status
[11:47:47.597] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:47.597] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:141:0) after 1m0s
[11:48:47.631] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:141:0)
[11:48:47.631] Timer tick, asking Buildbucket for the build status
[11:48:47.830] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:47.830] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:142:0) after 1m0s
[11:49:47.844] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:142:0)
[11:49:47.844] Timer tick, asking Buildbucket for the build status
[11:49:48.680] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:48.680] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:143:0) after 1m0s
[11:50:48.729] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:143:0)
[11:50:48.729] Timer tick, asking Buildbucket for the build status
[11:50:48.962] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:48.962] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:144:0) after 1m0s
[11:51:49.059] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:144:0)
[11:51:49.059] Timer tick, asking Buildbucket for the build status
[11:51:49.655] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:49.655] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:145:0) after 1m0s
[11:52:49.810] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:145:0)
[11:52:49.810] Timer tick, asking Buildbucket for the build status
[11:52:50.044] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:50.044] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:146:0) after 1m0s
[11:53:50.066] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:146:0)
[11:53:50.066] Timer tick, asking Buildbucket for the build status
[11:53:50.541] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:50.541] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:147:0) after 1m0s
[11:54:50.591] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:147:0)
[11:54:50.591] Timer tick, asking Buildbucket for the build status
[11:54:50.701] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:50.701] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:148:0) after 1m0s
[11:55:50.729] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:148:0)
[11:55:50.729] Timer tick, asking Buildbucket for the build status
[11:55:50.924] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:50.924] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:149:0) after 1m0s
[11:56:50.954] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:149:0)
[11:56:50.954] Timer tick, asking Buildbucket for the build status
[11:56:51.347] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:51.347] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:150:0) after 1m0s
[11:57:51.453] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:150:0)
[11:57:51.453] Timer tick, asking Buildbucket for the build status
[11:57:51.822] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:51.822] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:151:0) after 1m0s
[11:58:51.921] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:151:0)
[11:58:51.921] Timer tick, asking Buildbucket for the build status
[11:58:52.090] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:52.090] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:152:0) after 1m0s
[11:59:52.169] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:152:0)
[11:59:52.169] Timer tick, asking Buildbucket for the build status
[11:59:52.999] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:52.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:153:0) after 1m0s
[12:00:53.162] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:153:0)
[12:00:53.162] Timer tick, asking Buildbucket for the build status
[12:00:53.436] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:53.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:154:0) after 1m0s
[12:01:53.659] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:154:0)
[12:01:53.659] Timer tick, asking Buildbucket for the build status
[12:01:53.792] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:53.792] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:155:0) after 1m0s
[12:02:53.859] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:155:0)
[12:02:53.859] Timer tick, asking Buildbucket for the build status
[12:02:54.029] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:54.029] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:156:0) after 1m0s
[12:03:54.281] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:156:0)
[12:03:54.281] Timer tick, asking Buildbucket for the build status
[12:03:54.451] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:54.451] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:157:0) after 1m0s
[12:04:54.529] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:157:0)
[12:04:54.529] Timer tick, asking Buildbucket for the build status
[12:04:56.197] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:56.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:158:0) after 1m0s
[12:05:56.201] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:158:0)
[12:05:56.201] Timer tick, asking Buildbucket for the build status
[12:05:56.315] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:56.315] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:159:0) after 1m0s
[12:06:56.405] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:159:0)
[12:06:56.405] Timer tick, asking Buildbucket for the build status
[12:06:56.702] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:56.702] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:160:0) after 1m0s
[12:07:56.822] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:160:0)
[12:07:56.822] Timer tick, asking Buildbucket for the build status
[12:07:56.962] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:56.962] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:161:0) after 1m0s
[12:08:57.062] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:161:0)
[12:08:57.062] Timer tick, asking Buildbucket for the build status
[12:08:58.214] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:58.214] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:162:0) after 1m0s
[12:09:58.277] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:162:0)
[12:09:58.277] Timer tick, asking Buildbucket for the build status
[12:09:58.407] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:58.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:163:0) after 1m0s
[12:10:58.599] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:163:0)
[12:10:58.599] Timer tick, asking Buildbucket for the build status
[12:10:59.035] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:59.035] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:164:0) after 1m0s
[12:11:59.325] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:164:0)
[12:11:59.325] Timer tick, asking Buildbucket for the build status
[12:11:59.657] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:59.657] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:165:0) after 1m0s
[12:12:59.808] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:165:0)
[12:12:59.808] Timer tick, asking Buildbucket for the build status
[12:12:59.967] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:59.967] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:166:0) after 1m0s
[12:14:00.026] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:166:0)
[12:14:00.026] Timer tick, asking Buildbucket for the build status
[12:14:00.321] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:00.321] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:167:0) after 1m0s
[12:15:00.514] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:167:0)
[12:15:00.514] Timer tick, asking Buildbucket for the build status
[12:15:01.645] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:01.645] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:168:0) after 1m0s
[12:16:01.700] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:168:0)
[12:16:01.700] Timer tick, asking Buildbucket for the build status
[12:16:02.221] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:02.221] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:169:0) after 1m0s
[12:17:02.280] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:169:0)
[12:17:02.280] Timer tick, asking Buildbucket for the build status
[12:17:03.679] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:03.679] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:170:0) after 1m0s
[12:18:03.876] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:170:0)
[12:18:03.876] Timer tick, asking Buildbucket for the build status
[12:18:04.046] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:04.046] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:171:0) after 1m0s
[12:19:04.077] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:171:0)
[12:19:04.077] Timer tick, asking Buildbucket for the build status
[12:19:04.512] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:04.512] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:172:0) after 1m0s
[12:20:04.607] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:172:0)
[12:20:04.607] Timer tick, asking Buildbucket for the build status
[12:20:04.777] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:04.777] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:173:0) after 1m0s
[12:21:04.862] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:173:0)
[12:21:04.862] Timer tick, asking Buildbucket for the build status
[12:21:05.519] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:05.519] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:174:0) after 1m0s
[12:22:05.551] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:174:0)
[12:22:05.551] Timer tick, asking Buildbucket for the build status
[12:22:05.914] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:05.914] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:175:0) after 1m0s
[12:23:06.048] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:175:0)
[12:23:06.048] Timer tick, asking Buildbucket for the build status
[12:23:06.190] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:06.190] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:176:0) after 1m0s
[12:24:06.289] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:176:0)
[12:24:06.289] Timer tick, asking Buildbucket for the build status
[12:24:06.746] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:06.746] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:177:0) after 1m0s
[12:25:06.841] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:177:0)
[12:25:06.841] Timer tick, asking Buildbucket for the build status
[12:25:07.069] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:07.069] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:178:0) after 1m0s
[12:26:07.228] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:178:0)
[12:26:07.228] Timer tick, asking Buildbucket for the build status
[12:26:07.380] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:07.380] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:179:0) after 1m0s
[12:27:07.431] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:179:0)
[12:27:07.431] Timer tick, asking Buildbucket for the build status
[12:27:07.841] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:07.841] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:180:0) after 1m0s
[12:28:07.924] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:180:0)
[12:28:07.924] Timer tick, asking Buildbucket for the build status
[12:28:08.165] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:08.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:181:0) after 1m0s
[12:29:08.292] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:181:0)
[12:29:08.292] Timer tick, asking Buildbucket for the build status
[12:29:08.500] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:08.500] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:182:0) after 1m0s
[12:30:08.625] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:182:0)
[12:30:08.625] Timer tick, asking Buildbucket for the build status
[12:30:08.845] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:08.845] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:183:0) after 1m0s
[12:31:08.990] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:183:0)
[12:31:08.990] Timer tick, asking Buildbucket for the build status
[12:31:09.256] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:09.256] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:184:0) after 1m0s
[12:32:09.378] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:184:0)
[12:32:09.378] Timer tick, asking Buildbucket for the build status
[12:32:09.514] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:09.514] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:185:0) after 1m0s
[12:33:09.565] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:185:0)
[12:33:09.565] Timer tick, asking Buildbucket for the build status
[12:33:09.887] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:09.887] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:186:0) after 1m0s
[12:34:09.946] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:186:0)
[12:34:09.946] Timer tick, asking Buildbucket for the build status
[12:34:10.238] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:10.238] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:187:0) after 1m0s
[12:35:10.310] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:187:0)
[12:35:10.310] Timer tick, asking Buildbucket for the build status
[12:35:10.677] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:10.677] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:188:0) after 1m0s
[12:36:10.756] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:188:0)
[12:36:10.756] Timer tick, asking Buildbucket for the build status
[12:36:11.943] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:11.943] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:189:0) after 1m0s
[12:37:11.989] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:189:0)
[12:37:11.989] Timer tick, asking Buildbucket for the build status
[12:37:13.504] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:13.504] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:190:0) after 1m0s
[12:38:13.580] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:190:0)
[12:38:13.580] Timer tick, asking Buildbucket for the build status
[12:38:13.739] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:13.739] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:191:0) after 1m0s
[12:39:13.800] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:191:0)
[12:39:13.801] Timer tick, asking Buildbucket for the build status
[12:39:13.999] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:13.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:192:0) after 1m0s
[12:40:14.045] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:192:0)
[12:40:14.045] Timer tick, asking Buildbucket for the build status
[12:40:14.175] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:14.175] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:193:0) after 1m0s
[12:41:14.323] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:193:0)
[12:41:14.323] Timer tick, asking Buildbucket for the build status
[12:41:14.575] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:14.575] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:194:0) after 1m0s
[12:42:14.739] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:194:0)
[12:42:14.739] Timer tick, asking Buildbucket for the build status
[12:42:14.862] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:14.863] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:195:0) after 1m0s
[12:43:14.894] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:195:0)
[12:43:14.894] Timer tick, asking Buildbucket for the build status
[12:43:15.010] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:15.010] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:196:0) after 1m0s
[12:44:15.056] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:196:0)
[12:44:15.056] Timer tick, asking Buildbucket for the build status
[12:44:15.397] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:15.397] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:197:0) after 1m0s
[12:45:15.551] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:197:0)
[12:45:15.551] Timer tick, asking Buildbucket for the build status
[12:45:15.853] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:15.853] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:198:0) after 1m0s
[12:46:15.965] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:198:0)
[12:46:15.965] Timer tick, asking Buildbucket for the build status
[12:46:16.084] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:16.084] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:199:0) after 1m0s
[12:47:16.130] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:199:0)
[12:47:16.130] Timer tick, asking Buildbucket for the build status
[12:47:16.389] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:16.389] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:200:0) after 1m0s
[12:48:16.466] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:200:0)
[12:48:16.466] Timer tick, asking Buildbucket for the build status
[12:48:16.616] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:16.617] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:201:0) after 1m0s
[12:49:16.737] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:201:0)
[12:49:16.737] Timer tick, asking Buildbucket for the build status
[12:49:16.887] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:16.887] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:202:0) after 1m0s
[12:50:16.945] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:202:0)
[12:50:16.945] Timer tick, asking Buildbucket for the build status
[12:50:17.191] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:17.191] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:203:0) after 1m0s
[12:51:17.259] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:203:0)
[12:51:17.259] Timer tick, asking Buildbucket for the build status
[12:51:17.416] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:17.416] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:204:0) after 1m0s
[12:52:17.484] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:204:0)
[12:52:17.484] Timer tick, asking Buildbucket for the build status
[12:52:17.628] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:17.628] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:205:0) after 1m0s
[12:53:17.745] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:205:0)
[12:53:17.746] Timer tick, asking Buildbucket for the build status
[12:53:19.344] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:19.344] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:206:0) after 1m0s
[12:54:19.370] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:206:0)
[12:54:19.370] Timer tick, asking Buildbucket for the build status
[12:54:20.595] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:20.595] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:207:0) after 1m0s
[12:55:20.690] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:207:0)
[12:55:20.691] Timer tick, asking Buildbucket for the build status
[12:55:20.841] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:20.841] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:208:0) after 1m0s
[12:56:20.952] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:208:0)
[12:56:20.952] Timer tick, asking Buildbucket for the build status
[12:56:21.719] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:21.719] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:209:0) after 1m0s
[12:57:21.747] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:209:0)
[12:57:21.747] Timer tick, asking Buildbucket for the build status
[12:57:22.094] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:22.094] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:210:0) after 1m0s
[12:58:22.191] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:210:0)
[12:58:22.191] Timer tick, asking Buildbucket for the build status
[12:58:22.390] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:22.390] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:211:0) after 1m0s
[12:59:22.530] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:211:0)
[12:59:22.530] Timer tick, asking Buildbucket for the build status
[12:59:22.897] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:22.897] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:212:0) after 1m0s
[13:00:23.020] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:212:0)
[13:00:23.020] Timer tick, asking Buildbucket for the build status
[13:00:23.169] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:23.169] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:213:0) after 1m0s
[13:01:23.165] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:213:0)
[13:01:23.165] Timer tick, asking Buildbucket for the build status
[13:01:23.350] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:23.350] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:214:0) after 1m0s
[13:02:23.450] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:214:0)
[13:02:23.450] Timer tick, asking Buildbucket for the build status
[13:02:23.827] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:23.827] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:215:0) after 1m0s
[13:03:23.858] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:215:0)
[13:03:23.858] Timer tick, asking Buildbucket for the build status
[13:03:24.007] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:24.007] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:216:0) after 1m0s
[13:04:24.157] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:216:0)
[13:04:24.157] Timer tick, asking Buildbucket for the build status
[13:04:24.265] Build 8905793892122521712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:24.265] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9071223954144525376:217:0) after 1m0s
[13:05:07.691] Received PubSub notification, asking Buildbucket for the build status
[13:05:07.905] Build 8905793892122521712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:05:07.905] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1565183107038586",
"created_by": "project:r8",
"created_ts": "1565170120083994",
"id": "8905793892122521712",
"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\": \"201247876dd199d1fa464d5986383d1d5ff057a9\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@201247876dd199d1fa464d5986383d1d5ff057a9\", \"title\": \"201247876dd199d1fa464d5986383d1d5ff057a9\", \"url\": \"https://r8.googlesource.com/r8/+/201247876dd199d1fa464d5986383d1d5ff057a9\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"201247876dd199d1fa464d5986383d1d5ff057a9\"}}",
"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\": \"201247876dd199d1fa464d5986383d1d5ff057a9\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@201247876dd199d1fa464d5986383d1d5ff057a9\", \"title\": \"201247876dd199d1fa464d5986383d1d5ff057a9\", \"url\": \"https://r8.googlesource.com/r8/+/201247876dd199d1fa464d5986383d1d5ff057a9\"}]}, \"bot_id\": \"luci-r8-ci-internal-0-2if4\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-internal\", \"buildnumber\": 475, \"internal\": \"True\", \"mastername\": \"internal.client.r8\", \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"201247876dd199d1fa464d5986383d1d5ff057a9\"}, \"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-2if4\"], \"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\": [\"4382-5929880\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1565170124550234",
"status": "COMPLETED",
"status_changed_ts": "1565183107396085",
"tags": [
"build_address:luci.r8.ci/linux-internal/475",
"builder:linux-internal",
"buildset:commit/git/201247876dd199d1fa464d5986383d1d5ff057a9",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/201247876dd199d1fa464d5986383d1d5ff057a9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071223954144525376",
"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/8905793892122521712/+/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:46843a42fa555110",
"user_agent:luci-scheduler"
],
"updated_ts": "1565183107417981",
"url": "https://ci.chromium.org/b/8905793892122521712",
"utcnow_ts": "1565183107883275"
}
}
[13:05:07.905] Invocation finished in 3h36m29.134065488s with status SUCCEEDED