[13:50:40.962] New invocation is queued and will start shortly
[13:50:42.163] Starting the invocation (attempt 1)
[13:50:42.193] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:50:42.193] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:50:42.193] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9018751824701210752",
"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\":\"653864abd2b68c327c349b4b31b48cb0cb3c3cbb\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@653864abd2b68c327c349b4b31b48cb0cb3c3cbb\",\"title\":\"653864abd2b68c327c349b4b31b48cb0cb3c3cbb\",\"url\":\"https://r8.googlesource.com/r8/+/653864abd2b68c327c349b4b31b48cb0cb3c3cbb\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"f267365ab38de57d9129369d11a2bb462a0f9160\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@f267365ab38de57d9129369d11a2bb462a0f9160\",\"title\":\"f267365ab38de57d9129369d11a2bb462a0f9160\",\"url\":\"https://r8.googlesource.com/r8/+/f267365ab38de57d9129369d11a2bb462a0f9160\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@074cc63422f2c60c7f3b197f94a16ba38bdd52a7\",\"title\":\"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\",\"url\":\"https://r8.googlesource.com/r8/+/074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-internal",
"scheduler_invocation_id:9018751824701210752",
"scheduler_job_id:r8/linux-internal",
"user_agent:luci-scheduler",
"buildset:commit/git/074cc63422f2c60c7f3b197f94a16ba38bdd52a7",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/074cc63422f2c60c7f3b197f94a16ba38bdd52a7",
"gitiles_ref:refs/heads/master"
]
}
[13:50:43.203] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1615211442338376",
"id": "8853321762597077984",
"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\": \"653864abd2b68c327c349b4b31b48cb0cb3c3cbb\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@653864abd2b68c327c349b4b31b48cb0cb3c3cbb\", \"title\": \"653864abd2b68c327c349b4b31b48cb0cb3c3cbb\", \"url\": \"https://r8.googlesource.com/r8/+/653864abd2b68c327c349b4b31b48cb0cb3c3cbb\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"f267365ab38de57d9129369d11a2bb462a0f9160\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@f267365ab38de57d9129369d11a2bb462a0f9160\", \"title\": \"f267365ab38de57d9129369d11a2bb462a0f9160\", \"url\": \"https://r8.googlesource.com/r8/+/f267365ab38de57d9129369d11a2bb462a0f9160\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@074cc63422f2c60c7f3b197f94a16ba38bdd52a7\", \"title\": \"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\", \"url\": \"https://r8.googlesource.com/r8/+/074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615211442955749",
"tags": [
"build_address:luci.r8.ci/linux-internal/1684",
"builder:linux-internal",
"buildset:commit/git/074cc63422f2c60c7f3b197f94a16ba38bdd52a7",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/074cc63422f2c60c7f3b197f94a16ba38bdd52a7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018751824701210752",
"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/8853321762597077984/+/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": "1615211442956013",
"url": "https://ci.chromium.org/b/8853321762597077984",
"utcnow_ts": "1615211443177863"
}
}
[13:50:43.203] Task URL: https://ci.chromium.org/b/8853321762597077984
[13:50:43.203] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:2:0) after 1m0s
[13:51:24.039] Received PubSub notification, asking Buildbucket for the build status
[13:51:24.185] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:43.313] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:2:0)
[13:51:43.313] Timer tick, asking Buildbucket for the build status
[13:51:43.425] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:43.425] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:4:0) after 1m0s
[13:52:43.494] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:4:0)
[13:52:43.494] Timer tick, asking Buildbucket for the build status
[13:52:43.569] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:43.569] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:5:0) after 1m0s
[13:53:43.690] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:5:0)
[13:53:43.690] Timer tick, asking Buildbucket for the build status
[13:53:43.775] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:43.775] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:6:0) after 1m0s
[13:54:43.964] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:6:0)
[13:54:43.964] Timer tick, asking Buildbucket for the build status
[13:54:44.039] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:44.039] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:7:0) after 1m0s
[13:55:44.089] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:7:0)
[13:55:44.089] Timer tick, asking Buildbucket for the build status
[13:55:44.185] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:44.185] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:8:0) after 1m0s
[13:56:44.260] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:8:0)
[13:56:44.260] Timer tick, asking Buildbucket for the build status
[13:56:44.371] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:44.371] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:9:0) after 1m0s
[13:57:44.467] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:9:0)
[13:57:44.468] Timer tick, asking Buildbucket for the build status
[13:57:44.574] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:44.574] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:10:0) after 1m0s
[13:58:44.686] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:10:0)
[13:58:44.686] Timer tick, asking Buildbucket for the build status
[13:58:45.242] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:45.242] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:11:0) after 1m0s
[13:59:45.316] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:11:0)
[13:59:45.316] Timer tick, asking Buildbucket for the build status
[13:59:45.542] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:45.542] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:12:0) after 1m0s
[14:00:45.611] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:12:0)
[14:00:45.611] Timer tick, asking Buildbucket for the build status
[14:00:46.004] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:46.004] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:13:0) after 1m0s
[14:01:46.023] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:13:0)
[14:01:46.023] Timer tick, asking Buildbucket for the build status
[14:01:46.197] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:46.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:14:0) after 1m0s
[14:02:46.287] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:14:0)
[14:02:46.287] Timer tick, asking Buildbucket for the build status
[14:02:46.653] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:46.653] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:15:0) after 1m0s
[14:03:46.662] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:15:0)
[14:03:46.662] Timer tick, asking Buildbucket for the build status
[14:03:46.754] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:46.754] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:16:0) after 1m0s
[14:04:46.770] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:16:0)
[14:04:46.770] Timer tick, asking Buildbucket for the build status
[14:04:46.882] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:46.882] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:17:0) after 1m0s
[14:05:47.021] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:17:0)
[14:05:47.021] Timer tick, asking Buildbucket for the build status
[14:05:47.422] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:47.429] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:18:0) after 1m0s
[14:06:47.579] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:18:0)
[14:06:47.579] Timer tick, asking Buildbucket for the build status
[14:06:48.113] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:48.113] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:19:0) after 1m0s
[14:07:48.124] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:19:0)
[14:07:48.124] Timer tick, asking Buildbucket for the build status
[14:07:48.507] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:48.507] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:20:0) after 1m0s
[14:08:48.525] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:20:0)
[14:08:48.525] Timer tick, asking Buildbucket for the build status
[14:08:48.902] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:48.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:21:0) after 1m0s
[14:09:48.927] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:21:0)
[14:09:48.927] Timer tick, asking Buildbucket for the build status
[14:09:49.725] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:49.725] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:22:0) after 1m0s
[14:10:49.743] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:22:0)
[14:10:49.743] Timer tick, asking Buildbucket for the build status
[14:10:52.292] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:52.292] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:23:0) after 1m0s
[14:11:52.446] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:23:0)
[14:11:52.446] Timer tick, asking Buildbucket for the build status
[14:11:52.551] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:52.551] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:24:0) after 1m0s
[14:12:52.591] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:24:0)
[14:12:52.591] Timer tick, asking Buildbucket for the build status
[14:12:52.686] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:52.686] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:25:0) after 1m0s
[14:13:52.745] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:25:0)
[14:13:52.745] Timer tick, asking Buildbucket for the build status
[14:13:52.850] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:52.850] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:26:0) after 1m0s
[14:14:52.917] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:26:0)
[14:14:52.917] Timer tick, asking Buildbucket for the build status
[14:14:52.986] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:52.986] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:27:0) after 1m0s
[14:15:53.023] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:27:0)
[14:15:53.023] Timer tick, asking Buildbucket for the build status
[14:15:53.340] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:53.340] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:28:0) after 1m0s
[14:16:53.368] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:28:0)
[14:16:53.368] Timer tick, asking Buildbucket for the build status
[14:16:53.453] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:53.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:29:0) after 1m0s
[14:17:53.471] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:29:0)
[14:17:53.471] Timer tick, asking Buildbucket for the build status
[14:17:53.543] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:53.543] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:30:0) after 1m0s
[14:18:53.606] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:30:0)
[14:18:53.606] Timer tick, asking Buildbucket for the build status
[14:18:53.833] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:53.833] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:31:0) after 1m0s
[14:19:53.853] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:31:0)
[14:19:53.854] Timer tick, asking Buildbucket for the build status
[14:19:54.059] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:54.059] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:32:0) after 1m0s
[14:20:54.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:32:0)
[14:20:54.113] Timer tick, asking Buildbucket for the build status
[14:20:54.197] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:54.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:33:0) after 1m0s
[14:21:54.215] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:33:0)
[14:21:54.215] Timer tick, asking Buildbucket for the build status
[14:21:54.288] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:54.288] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:34:0) after 1m0s
[14:22:54.351] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:34:0)
[14:22:54.351] Timer tick, asking Buildbucket for the build status
[14:22:54.422] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:54.422] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:35:0) after 1m0s
[14:23:54.531] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:35:0)
[14:23:54.531] Timer tick, asking Buildbucket for the build status
[14:23:55.593] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:55.593] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:36:0) after 1m0s
[14:24:55.626] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:36:0)
[14:24:55.626] Timer tick, asking Buildbucket for the build status
[14:24:55.701] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:55.701] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:37:0) after 1m0s
[14:25:55.743] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:37:0)
[14:25:55.743] Timer tick, asking Buildbucket for the build status
[14:25:56.136] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:56.136] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:38:0) after 1m0s
[14:26:56.140] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:38:0)
[14:26:56.140] Timer tick, asking Buildbucket for the build status
[14:26:56.242] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:56.242] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:39:0) after 1m0s
[14:27:56.259] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:39:0)
[14:27:56.259] Timer tick, asking Buildbucket for the build status
[14:27:56.343] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:56.343] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:40:0) after 1m0s
[14:28:56.360] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:40:0)
[14:28:56.360] Timer tick, asking Buildbucket for the build status
[14:28:56.989] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:56.989] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:41:0) after 1m0s
[14:29:57.045] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:41:0)
[14:29:57.045] Timer tick, asking Buildbucket for the build status
[14:29:57.139] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:57.139] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:42:0) after 1m0s
[14:30:57.239] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:42:0)
[14:30:57.239] Timer tick, asking Buildbucket for the build status
[14:30:57.343] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:57.343] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:43:0) after 1m0s
[14:31:57.390] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:43:0)
[14:31:57.390] Timer tick, asking Buildbucket for the build status
[14:32:01.143] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:01.143] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:44:0) after 1m0s
[14:33:01.500] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:44:0)
[14:33:01.500] Timer tick, asking Buildbucket for the build status
[14:33:02.235] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:02.235] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:45:0) after 1m0s
[14:34:02.304] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:45:0)
[14:34:02.304] Timer tick, asking Buildbucket for the build status
[14:34:02.672] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:02.672] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:46:0) after 1m0s
[14:35:02.762] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:46:0)
[14:35:02.762] Timer tick, asking Buildbucket for the build status
[14:35:02.874] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:02.874] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:47:0) after 1m0s
[14:36:02.935] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:47:0)
[14:36:02.935] Timer tick, asking Buildbucket for the build status
[14:36:03.023] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:03.023] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:48:0) after 1m0s
[14:37:03.074] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:48:0)
[14:37:03.074] Timer tick, asking Buildbucket for the build status
[14:37:03.218] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:03.218] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:49:0) after 1m0s
[14:38:03.261] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:49:0)
[14:38:03.261] Timer tick, asking Buildbucket for the build status
[14:38:03.482] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:03.482] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:50:0) after 1m0s
[14:39:03.574] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:50:0)
[14:39:03.574] Timer tick, asking Buildbucket for the build status
[14:39:03.942] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:03.942] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:51:0) after 1m0s
[14:40:04.034] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:51:0)
[14:40:04.034] Timer tick, asking Buildbucket for the build status
[14:40:04.217] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:04.217] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:52:0) after 1m0s
[14:41:04.268] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:52:0)
[14:41:04.268] Timer tick, asking Buildbucket for the build status
[14:41:04.487] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:04.487] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:53:0) after 1m0s
[14:42:04.607] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:53:0)
[14:42:04.607] Timer tick, asking Buildbucket for the build status
[14:42:04.729] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:04.729] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:54:0) after 1m0s
[14:43:04.816] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:54:0)
[14:43:04.816] Timer tick, asking Buildbucket for the build status
[14:43:04.915] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:04.915] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:55:0) after 1m0s
[14:44:04.986] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:55:0)
[14:44:04.986] Timer tick, asking Buildbucket for the build status
[14:44:05.182] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:05.182] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:56:0) after 1m0s
[14:45:05.221] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:56:0)
[14:45:05.221] Timer tick, asking Buildbucket for the build status
[14:45:05.914] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:05.914] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:57:0) after 1m0s
[14:46:06.028] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:57:0)
[14:46:06.028] Timer tick, asking Buildbucket for the build status
[14:46:06.100] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:06.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:58:0) after 1m0s
[14:47:06.204] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:58:0)
[14:47:06.204] Timer tick, asking Buildbucket for the build status
[14:47:07.049] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:07.049] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:59:0) after 1m0s
[14:48:07.117] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:59:0)
[14:48:07.117] Timer tick, asking Buildbucket for the build status
[14:48:07.215] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:07.215] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:60:0) after 1m0s
[14:49:07.209] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:60:0)
[14:49:07.209] Timer tick, asking Buildbucket for the build status
[14:49:07.625] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:07.625] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:61:0) after 1m0s
[14:50:07.670] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:61:0)
[14:50:07.670] Timer tick, asking Buildbucket for the build status
[14:50:07.743] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:07.743] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:62:0) after 1m0s
[14:51:07.803] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:62:0)
[14:51:07.803] Timer tick, asking Buildbucket for the build status
[14:51:07.890] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:07.890] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:63:0) after 1m0s
[14:52:07.916] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:63:0)
[14:52:07.916] Timer tick, asking Buildbucket for the build status
[14:52:07.988] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:07.988] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:64:0) after 1m0s
[14:53:08.015] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:64:0)
[14:53:08.015] Timer tick, asking Buildbucket for the build status
[14:53:08.166] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:08.166] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:65:0) after 1m0s
[14:54:08.203] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:65:0)
[14:54:08.203] Timer tick, asking Buildbucket for the build status
[14:54:08.293] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:08.293] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:66:0) after 1m0s
[14:55:08.365] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:66:0)
[14:55:08.365] Timer tick, asking Buildbucket for the build status
[14:55:08.502] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:08.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:67:0) after 1m0s
[14:56:08.571] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:67:0)
[14:56:08.571] Timer tick, asking Buildbucket for the build status
[14:56:08.933] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:08.933] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:68:0) after 1m0s
[14:57:08.958] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:68:0)
[14:57:08.958] Timer tick, asking Buildbucket for the build status
[14:57:09.413] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:09.413] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:69:0) after 1m0s
[14:58:09.461] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:69:0)
[14:58:09.461] Timer tick, asking Buildbucket for the build status
[14:58:09.542] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:09.542] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:70:0) after 1m0s
[14:59:09.576] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:70:0)
[14:59:09.576] Timer tick, asking Buildbucket for the build status
[14:59:09.665] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:09.665] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:71:0) after 1m0s
[15:00:09.724] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:71:0)
[15:00:09.724] Timer tick, asking Buildbucket for the build status
[15:00:09.895] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:09.895] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:72:0) after 1m0s
[15:01:09.963] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:72:0)
[15:01:09.963] Timer tick, asking Buildbucket for the build status
[15:01:10.222] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:10.222] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:73:0) after 1m0s
[15:02:10.321] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:73:0)
[15:02:10.321] Timer tick, asking Buildbucket for the build status
[15:02:10.435] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:10.435] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:74:0) after 1m0s
[15:03:10.617] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:74:0)
[15:03:10.617] Timer tick, asking Buildbucket for the build status
[15:03:10.690] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:10.690] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:75:0) after 1m0s
[15:04:10.814] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:75:0)
[15:04:10.815] Timer tick, asking Buildbucket for the build status
[15:04:11.064] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:11.064] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:76:0) after 1m0s
[15:05:11.174] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:76:0)
[15:05:11.174] Timer tick, asking Buildbucket for the build status
[15:05:11.257] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:11.257] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:77:0) after 1m0s
[15:06:11.414] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:77:0)
[15:06:11.414] Timer tick, asking Buildbucket for the build status
[15:06:11.528] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:11.528] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:78:0) after 1m0s
[15:07:11.575] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:78:0)
[15:07:11.575] Timer tick, asking Buildbucket for the build status
[15:07:12.251] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:12.251] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:79:0) after 1m0s
[15:08:12.435] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:79:0)
[15:08:12.435] Timer tick, asking Buildbucket for the build status
[15:08:12.516] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:12.516] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:80:0) after 1m0s
[15:09:12.567] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:80:0)
[15:09:12.567] Timer tick, asking Buildbucket for the build status
[15:09:12.742] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:12.742] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:81:0) after 1m0s
[15:10:12.811] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:81:0)
[15:10:12.811] Timer tick, asking Buildbucket for the build status
[15:10:12.889] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:12.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:82:0) after 1m0s
[15:11:13.373] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:82:0)
[15:11:13.373] Timer tick, asking Buildbucket for the build status
[15:11:13.442] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:13.442] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:83:0) after 1m0s
[15:12:13.501] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:83:0)
[15:12:13.501] Timer tick, asking Buildbucket for the build status
[15:12:13.735] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:13.735] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:84:0) after 1m0s
[15:13:13.798] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:84:0)
[15:13:13.798] Timer tick, asking Buildbucket for the build status
[15:13:14.008] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:14.008] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:85:0) after 1m0s
[15:14:14.098] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:85:0)
[15:14:14.098] Timer tick, asking Buildbucket for the build status
[15:14:14.173] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:14.173] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:86:0) after 1m0s
[15:15:14.220] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:86:0)
[15:15:14.220] Timer tick, asking Buildbucket for the build status
[15:15:14.338] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:14.338] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:87:0) after 1m0s
[15:16:14.792] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:87:0)
[15:16:14.792] Timer tick, asking Buildbucket for the build status
[15:16:14.916] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:14.916] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:88:0) after 1m0s
[15:17:15.007] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:88:0)
[15:17:15.007] Timer tick, asking Buildbucket for the build status
[15:17:15.084] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:15.084] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:89:0) after 1m0s
[15:18:15.143] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:89:0)
[15:18:15.143] Timer tick, asking Buildbucket for the build status
[15:18:15.210] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:15.210] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:90:0) after 1m0s
[15:19:15.253] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:90:0)
[15:19:15.253] Timer tick, asking Buildbucket for the build status
[15:19:15.354] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:15.354] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:91:0) after 1m0s
[15:20:15.423] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:91:0)
[15:20:15.423] Timer tick, asking Buildbucket for the build status
[15:20:15.502] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:15.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:92:0) after 1m0s
[15:21:15.546] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:92:0)
[15:21:15.546] Timer tick, asking Buildbucket for the build status
[15:21:15.638] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:15.638] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:93:0) after 1m0s
[15:22:15.750] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:93:0)
[15:22:15.750] Timer tick, asking Buildbucket for the build status
[15:22:15.824] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:15.824] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:94:0) after 1m0s
[15:23:15.851] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:94:0)
[15:23:15.851] Timer tick, asking Buildbucket for the build status
[15:23:16.294] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:16.294] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:95:0) after 1m0s
[15:24:16.351] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:95:0)
[15:24:16.351] Timer tick, asking Buildbucket for the build status
[15:24:16.436] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:16.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:96:0) after 1m0s
[15:25:16.482] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:96:0)
[15:25:16.482] Timer tick, asking Buildbucket for the build status
[15:25:16.635] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:16.635] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:97:0) after 1m0s
[15:26:16.708] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:97:0)
[15:26:16.708] Timer tick, asking Buildbucket for the build status
[15:26:17.228] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:17.228] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:98:0) after 1m0s
[15:27:17.280] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:98:0)
[15:27:17.280] Timer tick, asking Buildbucket for the build status
[15:27:17.359] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:17.359] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:99:0) after 1m0s
[15:28:17.478] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:99:0)
[15:28:17.478] Timer tick, asking Buildbucket for the build status
[15:28:17.588] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:17.588] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:100:0) after 1m0s
[15:29:17.656] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:100:0)
[15:29:17.656] Timer tick, asking Buildbucket for the build status
[15:29:19.256] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:19.256] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:101:0) after 1m0s
[15:30:19.286] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:101:0)
[15:30:19.286] Timer tick, asking Buildbucket for the build status
[15:30:19.375] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:19.375] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:102:0) after 1m0s
[15:31:19.421] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:102:0)
[15:31:19.421] Timer tick, asking Buildbucket for the build status
[15:31:19.500] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:19.500] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:103:0) after 1m0s
[15:32:19.544] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:103:0)
[15:32:19.544] Timer tick, asking Buildbucket for the build status
[15:32:19.614] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:19.614] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:104:0) after 1m0s
[15:33:19.641] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:104:0)
[15:33:19.641] Timer tick, asking Buildbucket for the build status
[15:33:20.786] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:20.786] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:105:0) after 1m0s
[15:34:20.870] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:105:0)
[15:34:20.870] Timer tick, asking Buildbucket for the build status
[15:34:20.955] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:20.955] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:106:0) after 1m0s
[15:35:20.978] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:106:0)
[15:35:20.978] Timer tick, asking Buildbucket for the build status
[15:35:21.076] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:21.076] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:107:0) after 1m0s
[15:36:21.124] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:107:0)
[15:36:21.124] Timer tick, asking Buildbucket for the build status
[15:36:21.229] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:21.229] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:108:0) after 1m0s
[15:37:21.264] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:108:0)
[15:37:21.264] Timer tick, asking Buildbucket for the build status
[15:37:21.354] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:21.354] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:109:0) after 1m0s
[15:38:21.429] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:109:0)
[15:38:21.429] Timer tick, asking Buildbucket for the build status
[15:38:21.533] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:21.533] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:110:0) after 1m0s
[15:39:21.576] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:110:0)
[15:39:21.576] Timer tick, asking Buildbucket for the build status
[15:39:21.695] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:21.695] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:111:0) after 1m0s
[15:40:21.774] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:111:0)
[15:40:21.774] Timer tick, asking Buildbucket for the build status
[15:40:21.854] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:21.854] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:112:0) after 1m0s
[15:41:21.892] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:112:0)
[15:41:21.892] Timer tick, asking Buildbucket for the build status
[15:41:21.963] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:21.963] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:113:0) after 1m0s
[15:42:21.986] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:113:0)
[15:42:21.986] Timer tick, asking Buildbucket for the build status
[15:42:22.191] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:22.191] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:114:0) after 1m0s
[15:43:22.329] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:114:0)
[15:43:22.329] Timer tick, asking Buildbucket for the build status
[15:43:22.404] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:22.404] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:115:0) after 1m0s
[15:44:22.500] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:115:0)
[15:44:22.500] Timer tick, asking Buildbucket for the build status
[15:44:22.601] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:22.601] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:116:0) after 1m0s
[15:45:22.828] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:116:0)
[15:45:22.828] Timer tick, asking Buildbucket for the build status
[15:45:23.258] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:23.258] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:117:0) after 1m0s
[15:46:23.300] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:117:0)
[15:46:23.300] Timer tick, asking Buildbucket for the build status
[15:46:23.508] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:23.508] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:118:0) after 1m0s
[15:47:23.600] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:118:0)
[15:47:23.600] Timer tick, asking Buildbucket for the build status
[15:47:23.948] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:23.948] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:119:0) after 1m0s
[15:48:24.041] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:119:0)
[15:48:24.041] Timer tick, asking Buildbucket for the build status
[15:48:24.195] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:24.195] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:120:0) after 1m0s
[15:49:24.407] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:120:0)
[15:49:24.407] Timer tick, asking Buildbucket for the build status
[15:49:24.610] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:24.610] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:121:0) after 1m0s
[15:50:24.774] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:121:0)
[15:50:24.774] Timer tick, asking Buildbucket for the build status
[15:50:24.922] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:24.922] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:122:0) after 1m0s
[15:51:25.045] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:122:0)
[15:51:25.045] Timer tick, asking Buildbucket for the build status
[15:51:25.267] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:25.267] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:123:0) after 1m0s
[15:52:25.335] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:123:0)
[15:52:25.335] Timer tick, asking Buildbucket for the build status
[15:52:25.418] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:25.418] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:124:0) after 1m0s
[15:53:25.437] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:124:0)
[15:53:25.437] Timer tick, asking Buildbucket for the build status
[15:53:25.979] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:25.979] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:125:0) after 1m0s
[15:54:26.035] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:125:0)
[15:54:26.035] Timer tick, asking Buildbucket for the build status
[15:54:26.139] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:26.139] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:126:0) after 1m0s
[15:55:26.199] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:126:0)
[15:55:26.199] Timer tick, asking Buildbucket for the build status
[15:55:26.332] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:26.332] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:127:0) after 1m0s
[15:56:26.338] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:127:0)
[15:56:26.338] Timer tick, asking Buildbucket for the build status
[15:56:26.698] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:26.698] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:128:0) after 1m0s
[15:57:26.796] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:128:0)
[15:57:26.796] Timer tick, asking Buildbucket for the build status
[15:57:29.998] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:29.998] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:129:0) after 1m0s
[15:58:30.041] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:129:0)
[15:58:30.041] Timer tick, asking Buildbucket for the build status
[15:58:30.121] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:30.121] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:130:0) after 1m0s
[15:59:30.196] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:130:0)
[15:59:30.196] Timer tick, asking Buildbucket for the build status
[15:59:30.268] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:30.268] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:131:0) after 1m0s
[16:00:30.360] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:131:0)
[16:00:30.360] Timer tick, asking Buildbucket for the build status
[16:00:30.431] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:30.431] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:132:0) after 1m0s
[16:01:30.525] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:132:0)
[16:01:30.525] Timer tick, asking Buildbucket for the build status
[16:01:30.598] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:30.598] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:133:0) after 1m0s
[16:02:30.633] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:133:0)
[16:02:30.633] Timer tick, asking Buildbucket for the build status
[16:02:30.734] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:30.734] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:134:0) after 1m0s
[16:03:30.754] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:134:0)
[16:03:30.754] Timer tick, asking Buildbucket for the build status
[16:03:30.851] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:30.851] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:135:0) after 1m0s
[16:04:30.880] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:135:0)
[16:04:30.880] Timer tick, asking Buildbucket for the build status
[16:04:31.353] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:31.353] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:136:0) after 1m0s
[16:05:31.392] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:136:0)
[16:05:31.392] Timer tick, asking Buildbucket for the build status
[16:05:31.553] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:31.553] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:137:0) after 1m0s
[16:06:31.689] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:137:0)
[16:06:31.689] Timer tick, asking Buildbucket for the build status
[16:06:31.767] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:31.767] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:138:0) after 1m0s
[16:07:31.837] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:138:0)
[16:07:31.837] Timer tick, asking Buildbucket for the build status
[16:07:32.244] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:32.244] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:139:0) after 1m0s
[16:08:32.260] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:139:0)
[16:08:32.260] Timer tick, asking Buildbucket for the build status
[16:08:32.444] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:32.444] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:140:0) after 1m0s
[16:09:32.559] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:140:0)
[16:09:32.560] Timer tick, asking Buildbucket for the build status
[16:09:32.746] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:32.746] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:141:0) after 1m0s
[16:10:32.766] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:141:0)
[16:10:32.766] Timer tick, asking Buildbucket for the build status
[16:10:32.860] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:32.860] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:142:0) after 1m0s
[16:11:32.878] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:142:0)
[16:11:32.878] Timer tick, asking Buildbucket for the build status
[16:11:34.001] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:34.001] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:143:0) after 1m0s
[16:12:34.054] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:143:0)
[16:12:34.054] Timer tick, asking Buildbucket for the build status
[16:12:34.171] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:34.171] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:144:0) after 1m0s
[16:13:34.301] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:144:0)
[16:13:34.301] Timer tick, asking Buildbucket for the build status
[16:13:34.378] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:34.378] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:145:0) after 1m0s
[16:14:34.408] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:145:0)
[16:14:34.408] Timer tick, asking Buildbucket for the build status
[16:14:34.531] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:34.531] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:146:0) after 1m0s
[16:15:35.653] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:146:0)
[16:15:35.653] Timer tick, asking Buildbucket for the build status
[16:15:35.729] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:35.729] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:147:0) after 1m0s
[16:16:35.767] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:147:0)
[16:16:35.767] Timer tick, asking Buildbucket for the build status
[16:16:35.873] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:35.873] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:148:0) after 1m0s
[16:17:35.861] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:148:0)
[16:17:35.861] Timer tick, asking Buildbucket for the build status
[16:17:36.241] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:36.241] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:149:0) after 1m0s
[16:18:36.365] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:149:0)
[16:18:36.365] Timer tick, asking Buildbucket for the build status
[16:18:36.481] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:36.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:150:0) after 1m0s
[16:19:36.542] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:150:0)
[16:19:36.542] Timer tick, asking Buildbucket for the build status
[16:19:36.608] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:36.608] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:151:0) after 1m0s
[16:20:36.692] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:151:0)
[16:20:36.692] Timer tick, asking Buildbucket for the build status
[16:20:36.762] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:36.762] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:152:0) after 1m0s
[16:21:36.803] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:152:0)
[16:21:36.803] Timer tick, asking Buildbucket for the build status
[16:21:36.900] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:36.900] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:153:0) after 1m0s
[16:22:36.922] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:153:0)
[16:22:36.922] Timer tick, asking Buildbucket for the build status
[16:22:37.007] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:37.007] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:154:0) after 1m0s
[16:23:37.037] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:154:0)
[16:23:37.037] Timer tick, asking Buildbucket for the build status
[16:23:37.883] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:37.883] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:155:0) after 1m0s
[16:24:38.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:155:0)
[16:24:38.113] Timer tick, asking Buildbucket for the build status
[16:24:38.190] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:38.190] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:156:0) after 1m0s
[16:25:38.247] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:156:0)
[16:25:38.247] Timer tick, asking Buildbucket for the build status
[16:25:38.645] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:38.645] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:157:0) after 1m0s
[16:26:38.836] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:157:0)
[16:26:38.836] Timer tick, asking Buildbucket for the build status
[16:26:39.231] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:39.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:158:0) after 1m0s
[16:27:39.425] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:158:0)
[16:27:39.425] Timer tick, asking Buildbucket for the build status
[16:27:39.523] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:39.523] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:159:0) after 1m0s
[16:28:41.293] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:159:0)
[16:28:41.293] Timer tick, asking Buildbucket for the build status
[16:28:41.527] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:41.527] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:160:0) after 1m0s
[16:29:41.564] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:160:0)
[16:29:41.564] Timer tick, asking Buildbucket for the build status
[16:29:43.473] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:43.473] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:161:0) after 1m0s
[16:30:43.715] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:161:0)
[16:30:43.715] Timer tick, asking Buildbucket for the build status
[16:30:43.798] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:43.798] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:162:0) after 1m0s
[16:31:44.013] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:162:0)
[16:31:44.013] Timer tick, asking Buildbucket for the build status
[16:31:44.467] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:44.467] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:163:0) after 1m0s
[16:32:44.536] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:163:0)
[16:32:44.536] Timer tick, asking Buildbucket for the build status
[16:32:46.405] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:46.405] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:164:0) after 1m0s
[16:33:46.467] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:164:0)
[16:33:46.467] Timer tick, asking Buildbucket for the build status
[16:33:46.553] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:46.553] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:165:0) after 1m0s
[16:34:46.717] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:165:0)
[16:34:46.717] Timer tick, asking Buildbucket for the build status
[16:34:46.792] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:46.792] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:166:0) after 1m0s
[16:35:46.795] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:166:0)
[16:35:46.795] Timer tick, asking Buildbucket for the build status
[16:35:46.880] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:46.880] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:167:0) after 1m0s
[16:36:46.909] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:167:0)
[16:36:46.909] Timer tick, asking Buildbucket for the build status
[16:36:46.982] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:46.982] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:168:0) after 1m0s
[16:37:47.260] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:168:0)
[16:37:47.260] Timer tick, asking Buildbucket for the build status
[16:37:47.478] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:47.478] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:169:0) after 1m0s
[16:38:47.600] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:169:0)
[16:38:47.600] Timer tick, asking Buildbucket for the build status
[16:38:48.055] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:48.055] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:170:0) after 1m0s
[16:39:48.040] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:170:0)
[16:39:48.040] Timer tick, asking Buildbucket for the build status
[16:39:48.126] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:48.126] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:171:0) after 1m0s
[16:40:48.215] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:171:0)
[16:40:48.215] Timer tick, asking Buildbucket for the build status
[16:40:48.434] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:48.434] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:172:0) after 1m0s
[16:41:48.444] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:172:0)
[16:41:48.444] Timer tick, asking Buildbucket for the build status
[16:41:48.516] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:48.516] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:173:0) after 1m0s
[16:42:48.788] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:173:0)
[16:42:48.788] Timer tick, asking Buildbucket for the build status
[16:42:49.006] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:49.006] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:174:0) after 1m0s
[16:43:49.141] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:174:0)
[16:43:49.141] Timer tick, asking Buildbucket for the build status
[16:43:49.501] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:49.501] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:175:0) after 1m0s
[16:44:49.566] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:175:0)
[16:44:49.566] Timer tick, asking Buildbucket for the build status
[16:44:49.655] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:49.655] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:176:0) after 1m0s
[16:45:49.695] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:176:0)
[16:45:49.696] Timer tick, asking Buildbucket for the build status
[16:45:49.773] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:49.773] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:177:0) after 1m0s
[16:46:49.834] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:177:0)
[16:46:49.834] Timer tick, asking Buildbucket for the build status
[16:46:49.903] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:49.903] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:178:0) after 1m0s
[16:47:50.002] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:178:0)
[16:47:50.002] Timer tick, asking Buildbucket for the build status
[16:47:50.142] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:50.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:179:0) after 1m0s
[16:48:50.220] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:179:0)
[16:48:50.220] Timer tick, asking Buildbucket for the build status
[16:48:53.156] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:53.156] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:180:0) after 1m0s
[16:49:53.553] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:180:0)
[16:49:53.553] Timer tick, asking Buildbucket for the build status
[16:49:53.626] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:53.626] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:181:0) after 1m0s
[16:50:54.102] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:181:0)
[16:50:54.102] Timer tick, asking Buildbucket for the build status
[16:50:54.182] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:54.182] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:182:0) after 1m0s
[16:51:54.546] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:182:0)
[16:51:54.546] Timer tick, asking Buildbucket for the build status
[16:51:54.641] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:54.641] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:183:0) after 1m0s
[16:52:54.900] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:183:0)
[16:52:54.900] Timer tick, asking Buildbucket for the build status
[16:52:55.254] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:55.254] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:184:0) after 1m0s
[16:53:55.275] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:184:0)
[16:53:55.275] Timer tick, asking Buildbucket for the build status
[16:53:55.453] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:55.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:185:0) after 1m0s
[16:54:55.736] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:185:0)
[16:54:55.736] Timer tick, asking Buildbucket for the build status
[16:54:55.814] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:55.814] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:186:0) after 1m0s
[16:55:55.819] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:186:0)
[16:55:55.819] Timer tick, asking Buildbucket for the build status
[16:55:55.966] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:55.966] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:187:0) after 1m0s
[16:56:55.977] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:187:0)
[16:56:55.977] Timer tick, asking Buildbucket for the build status
[16:56:57.114] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:57.114] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:188:0) after 1m0s
[16:57:57.173] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:188:0)
[16:57:57.173] Timer tick, asking Buildbucket for the build status
[16:57:57.245] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:57.245] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:189:0) after 1m0s
[16:58:57.291] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:189:0)
[16:58:57.291] Timer tick, asking Buildbucket for the build status
[16:58:57.364] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:57.364] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:190:0) after 1m0s
[16:59:57.394] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:190:0)
[16:59:57.394] Timer tick, asking Buildbucket for the build status
[16:59:57.625] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:57.625] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:191:0) after 1m0s
[17:00:57.672] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:191:0)
[17:00:57.672] Timer tick, asking Buildbucket for the build status
[17:00:57.743] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:57.743] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:192:0) after 1m0s
[17:01:57.844] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:192:0)
[17:01:57.844] Timer tick, asking Buildbucket for the build status
[17:01:58.191] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:58.191] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:193:0) after 1m0s
[17:02:58.236] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:193:0)
[17:02:58.236] Timer tick, asking Buildbucket for the build status
[17:02:58.309] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:58.309] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:194:0) after 1m0s
[17:03:58.363] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:194:0)
[17:03:58.363] Timer tick, asking Buildbucket for the build status
[17:03:58.537] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:58.537] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:195:0) after 1m0s
[17:04:58.627] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:195:0)
[17:04:58.627] Timer tick, asking Buildbucket for the build status
[17:04:58.718] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:58.718] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:196:0) after 1m0s
[17:05:58.737] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:196:0)
[17:05:58.737] Timer tick, asking Buildbucket for the build status
[17:05:58.901] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:58.901] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:197:0) after 1m0s
[17:06:58.946] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:197:0)
[17:06:58.946] Timer tick, asking Buildbucket for the build status
[17:06:59.047] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:59.047] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:198:0) after 1m0s
[17:07:59.063] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:198:0)
[17:07:59.063] Timer tick, asking Buildbucket for the build status
[17:07:59.166] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:59.166] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:199:0) after 1m0s
[17:08:59.193] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:199:0)
[17:08:59.193] Timer tick, asking Buildbucket for the build status
[17:08:59.310] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:59.310] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:200:0) after 1m0s
[17:09:59.344] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:200:0)
[17:09:59.344] Timer tick, asking Buildbucket for the build status
[17:09:59.577] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:59.577] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:201:0) after 1m0s
[17:10:59.611] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:201:0)
[17:10:59.611] Timer tick, asking Buildbucket for the build status
[17:10:59.962] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:59.962] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:202:0) after 1m0s
[17:12:00.009] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:202:0)
[17:12:00.009] Timer tick, asking Buildbucket for the build status
[17:12:00.246] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:00.246] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:203:0) after 1m0s
[17:13:00.274] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:203:0)
[17:13:00.274] Timer tick, asking Buildbucket for the build status
[17:13:00.491] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:00.491] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:204:0) after 1m0s
[17:14:00.562] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:204:0)
[17:14:00.562] Timer tick, asking Buildbucket for the build status
[17:14:00.738] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:00.738] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:205:0) after 1m0s
[17:15:00.832] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:205:0)
[17:15:00.832] Timer tick, asking Buildbucket for the build status
[17:15:00.935] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:00.935] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:206:0) after 1m0s
[17:16:01.341] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:206:0)
[17:16:01.341] Timer tick, asking Buildbucket for the build status
[17:16:01.435] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:01.435] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:207:0) after 1m0s
[17:17:01.691] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:207:0)
[17:17:01.691] Timer tick, asking Buildbucket for the build status
[17:17:03.438] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:03.438] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:208:0) after 1m0s
[17:18:03.475] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:208:0)
[17:18:03.475] Timer tick, asking Buildbucket for the build status
[17:18:03.559] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:03.559] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:209:0) after 1m0s
[17:19:03.651] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:209:0)
[17:19:03.651] Timer tick, asking Buildbucket for the build status
[17:19:04.359] Build 8853321762597077984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:04.359] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9018751824701210752:210:0) after 1m0s
[17:19:55.504] Received PubSub notification, asking Buildbucket for the build status
[17:19:55.576] Build 8853321762597077984: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[17:19:55.576] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1615223995006557",
"created_by": "project:r8",
"created_ts": "1615211442338376",
"failure_reason": "BUILD_FAILURE",
"id": "8853321762597077984",
"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\": \"653864abd2b68c327c349b4b31b48cb0cb3c3cbb\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@653864abd2b68c327c349b4b31b48cb0cb3c3cbb\", \"title\": \"653864abd2b68c327c349b4b31b48cb0cb3c3cbb\", \"url\": \"https://r8.googlesource.com/r8/+/653864abd2b68c327c349b4b31b48cb0cb3c3cbb\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"f267365ab38de57d9129369d11a2bb462a0f9160\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@f267365ab38de57d9129369d11a2bb462a0f9160\", \"title\": \"f267365ab38de57d9129369d11a2bb462a0f9160\", \"url\": \"https://r8.googlesource.com/r8/+/f267365ab38de57d9129369d11a2bb462a0f9160\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@074cc63422f2c60c7f3b197f94a16ba38bdd52a7\", \"title\": \"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\", \"url\": \"https://r8.googlesource.com/r8/+/074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"}}",
"project": "r8",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('Run internal') (retcode: 1)\"}, \"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\": \"653864abd2b68c327c349b4b31b48cb0cb3c3cbb\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@653864abd2b68c327c349b4b31b48cb0cb3c3cbb\", \"title\": \"653864abd2b68c327c349b4b31b48cb0cb3c3cbb\", \"url\": \"https://r8.googlesource.com/r8/+/653864abd2b68c327c349b4b31b48cb0cb3c3cbb\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"f267365ab38de57d9129369d11a2bb462a0f9160\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@f267365ab38de57d9129369d11a2bb462a0f9160\", \"title\": \"f267365ab38de57d9129369d11a2bb462a0f9160\", \"url\": \"https://r8.googlesource.com/r8/+/f267365ab38de57d9129369d11a2bb462a0f9160\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@074cc63422f2c60c7f3b197f94a16ba38bdd52a7\", \"title\": \"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\", \"url\": \"https://r8.googlesource.com/r8/+/074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"}]}, \"bot_id\": \"luci-r8-custom-ci-internal-0-fa7i\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-internal\", \"buildnumber\": 1684, \"internal\": \"True\", \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"074cc63422f2c60c7f3b197f94a16ba38bdd52a7\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_900ab73f001a0fd66671af46f52d62d2e286e9fa85c81d9145d576573008cd6c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"2\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"r8bot-265908\"], \"gpu\": [\"none\"], \"id\": [\"luci-r8-custom-ci-internal-0-fa7i\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"internal\": [\"true\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-2\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.r8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5744-5c0a4b4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}, \"ui\": {\"info\": \"Step('Run internal') (retcode: 1)\"}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615211482103314",
"status": "COMPLETED",
"status_changed_ts": "1615211483577413",
"tags": [
"build_address:luci.r8.ci/linux-internal/1684",
"builder:linux-internal",
"buildset:commit/git/074cc63422f2c60c7f3b197f94a16ba38bdd52a7",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/074cc63422f2c60c7f3b197f94a16ba38bdd52a7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018751824701210752",
"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/8853321762597077984/+/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:522aec3cb2a53f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615223995006976",
"url": "https://ci.chromium.org/b/8853321762597077984",
"utcnow_ts": "1615223995570242"
}
}
[17:19:55.576] Invocation finished in 3h29m14.627528264s with status FAILED