[10:20:53.941] New invocation is queued and will start shortly
[10:20:55.052] Starting the invocation (attempt 1)
[10:20:55.107] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:20:55.107] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:20:55.107] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9028730689459333456",
"parameters_json": "{\"builder_name\":\"linux-jdk8\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\",\"title\":\"8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\",\"url\":\"https://r8.googlesource.com/r8/+/8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"297c09826f16bb9080cbd94b612570d55113e280\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@297c09826f16bb9080cbd94b612570d55113e280\",\"title\":\"297c09826f16bb9080cbd94b612570d55113e280\",\"url\":\"https://r8.googlesource.com/r8/+/297c09826f16bb9080cbd94b612570d55113e280\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"297c09826f16bb9080cbd94b612570d55113e280\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-jdk8",
"scheduler_invocation_id:9028730689459333456",
"scheduler_job_id:r8/linux-jdk8",
"user_agent:luci-scheduler",
"buildset:commit/git/297c09826f16bb9080cbd94b612570d55113e280",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/297c09826f16bb9080cbd94b612570d55113e280",
"gitiles_ref:refs/heads/master"
]
}
[10:20:56.393] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1605694855551306",
"id": "8863300627103600768",
"parameters_json": "{\"builder_name\": \"linux-jdk8\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\", \"title\": \"8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\", \"url\": \"https://r8.googlesource.com/r8/+/8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"297c09826f16bb9080cbd94b612570d55113e280\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@297c09826f16bb9080cbd94b612570d55113e280\", \"title\": \"297c09826f16bb9080cbd94b612570d55113e280\", \"url\": \"https://r8.googlesource.com/r8/+/297c09826f16bb9080cbd94b612570d55113e280\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"297c09826f16bb9080cbd94b612570d55113e280\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605694856100613",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/163",
"builder:linux-jdk8",
"buildset:commit/git/297c09826f16bb9080cbd94b612570d55113e280",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/297c09826f16bb9080cbd94b612570d55113e280",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028730689459333456",
"scheduler_job_id:r8/linux-jdk8",
"swarming_hostname:chrome-swarming.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/r8/buildbucket/cr-buildbucket.appspot.com/8863300627103600768/+/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": "1605694856100722",
"url": "https://ci.chromium.org/b/8863300627103600768",
"utcnow_ts": "1605694856384466"
}
}
[10:20:56.393] Task URL: https://ci.chromium.org/b/8863300627103600768
[10:20:56.393] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:2:0) after 1m0s
[10:21:32.117] Received PubSub notification, asking Buildbucket for the build status
[10:21:32.200] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:56.461] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:2:0)
[10:21:56.461] Timer tick, asking Buildbucket for the build status
[10:21:56.583] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:56.583] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:4:0) after 1m0s
[10:22:56.574] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:4:0)
[10:22:56.574] Timer tick, asking Buildbucket for the build status
[10:22:56.789] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:56.789] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:5:0) after 1m0s
[10:23:56.971] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:5:0)
[10:23:56.971] Timer tick, asking Buildbucket for the build status
[10:23:57.036] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:57.036] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:6:0) after 1m0s
[10:24:57.051] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:6:0)
[10:24:57.051] Timer tick, asking Buildbucket for the build status
[10:24:57.134] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:57.134] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:7:0) after 1m0s
[10:25:57.126] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:7:0)
[10:25:57.126] Timer tick, asking Buildbucket for the build status
[10:25:57.187] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:57.187] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:8:0) after 1m0s
[10:26:57.215] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:8:0)
[10:26:57.215] Timer tick, asking Buildbucket for the build status
[10:26:57.818] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:57.818] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:9:0) after 1m0s
[10:27:57.866] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:9:0)
[10:27:57.866] Timer tick, asking Buildbucket for the build status
[10:27:57.941] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:57.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:10:0) after 1m0s
[10:28:57.966] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:10:0)
[10:28:57.966] Timer tick, asking Buildbucket for the build status
[10:28:58.027] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:58.027] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:11:0) after 1m0s
[10:29:58.070] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:11:0)
[10:29:58.070] Timer tick, asking Buildbucket for the build status
[10:29:58.140] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:58.140] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:12:0) after 1m0s
[10:30:58.310] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:12:0)
[10:30:58.310] Timer tick, asking Buildbucket for the build status
[10:30:58.459] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:58.459] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:13:0) after 1m0s
[10:31:58.543] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:13:0)
[10:31:58.543] Timer tick, asking Buildbucket for the build status
[10:31:58.937] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:58.937] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:14:0) after 1m0s
[10:32:59.016] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:14:0)
[10:32:59.016] Timer tick, asking Buildbucket for the build status
[10:32:59.124] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:59.125] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:15:0) after 1m0s
[10:33:59.163] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:15:0)
[10:33:59.163] Timer tick, asking Buildbucket for the build status
[10:33:59.244] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:59.244] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:16:0) after 1m0s
[10:34:59.313] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:16:0)
[10:34:59.313] Timer tick, asking Buildbucket for the build status
[10:34:59.380] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:59.380] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:17:0) after 1m0s
[10:35:59.462] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:17:0)
[10:35:59.462] Timer tick, asking Buildbucket for the build status
[10:35:59.587] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:59.587] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:18:0) after 1m0s
[10:36:59.670] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:18:0)
[10:36:59.670] Timer tick, asking Buildbucket for the build status
[10:36:59.744] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:59.744] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:19:0) after 1m0s
[10:37:59.771] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:19:0)
[10:37:59.771] Timer tick, asking Buildbucket for the build status
[10:37:59.857] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:59.857] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:20:0) after 1m0s
[10:38:59.918] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:20:0)
[10:38:59.918] Timer tick, asking Buildbucket for the build status
[10:39:00.213] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:00.213] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:21:0) after 1m0s
[10:40:00.291] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:21:0)
[10:40:00.291] Timer tick, asking Buildbucket for the build status
[10:40:00.438] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:00.438] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:22:0) after 1m0s
[10:41:00.460] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:22:0)
[10:41:00.460] Timer tick, asking Buildbucket for the build status
[10:41:00.657] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:00.657] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:23:0) after 1m0s
[10:42:01.294] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:23:0)
[10:42:01.294] Timer tick, asking Buildbucket for the build status
[10:42:01.375] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:01.375] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:24:0) after 1m0s
[10:43:01.383] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:24:0)
[10:43:01.383] Timer tick, asking Buildbucket for the build status
[10:43:01.456] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:01.456] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:25:0) after 1m0s
[10:44:01.484] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:25:0)
[10:44:01.485] Timer tick, asking Buildbucket for the build status
[10:44:01.632] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:01.632] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:26:0) after 1m0s
[10:45:01.801] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:26:0)
[10:45:01.801] Timer tick, asking Buildbucket for the build status
[10:45:01.864] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:01.864] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:27:0) after 1m0s
[10:46:01.909] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:27:0)
[10:46:01.909] Timer tick, asking Buildbucket for the build status
[10:46:02.071] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:02.071] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:28:0) after 1m0s
[10:47:02.147] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:28:0)
[10:47:02.147] Timer tick, asking Buildbucket for the build status
[10:47:02.211] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:02.211] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:29:0) after 1m0s
[10:48:02.197] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:29:0)
[10:48:02.198] Timer tick, asking Buildbucket for the build status
[10:48:02.285] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:02.285] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:30:0) after 1m0s
[10:49:02.454] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:30:0)
[10:49:02.454] Timer tick, asking Buildbucket for the build status
[10:49:02.921] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:02.921] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:31:0) after 1m0s
[10:50:03.078] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:31:0)
[10:50:03.078] Timer tick, asking Buildbucket for the build status
[10:50:03.320] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:03.320] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:32:0) after 1m0s
[10:51:03.382] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:32:0)
[10:51:03.382] Timer tick, asking Buildbucket for the build status
[10:51:03.511] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:03.511] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:33:0) after 1m0s
[10:52:03.585] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:33:0)
[10:52:03.585] Timer tick, asking Buildbucket for the build status
[10:52:03.714] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:03.714] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:34:0) after 1m0s
[10:53:03.771] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:34:0)
[10:53:03.771] Timer tick, asking Buildbucket for the build status
[10:53:03.851] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:03.851] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:35:0) after 1m0s
[10:54:03.905] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:35:0)
[10:54:03.905] Timer tick, asking Buildbucket for the build status
[10:54:04.238] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:04.238] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:36:0) after 1m0s
[10:55:04.328] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:36:0)
[10:55:04.328] Timer tick, asking Buildbucket for the build status
[10:55:04.429] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:04.429] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:37:0) after 1m0s
[10:56:04.484] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:37:0)
[10:56:04.484] Timer tick, asking Buildbucket for the build status
[10:56:04.613] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:04.613] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:38:0) after 1m0s
[10:57:04.740] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:38:0)
[10:57:04.740] Timer tick, asking Buildbucket for the build status
[10:57:04.801] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:04.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:39:0) after 1m0s
[10:58:04.836] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:39:0)
[10:58:04.836] Timer tick, asking Buildbucket for the build status
[10:58:04.902] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:04.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:40:0) after 1m0s
[10:59:04.941] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:40:0)
[10:59:04.941] Timer tick, asking Buildbucket for the build status
[10:59:05.006] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:05.006] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:41:0) after 1m0s
[11:00:05.131] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:41:0)
[11:00:05.131] Timer tick, asking Buildbucket for the build status
[11:00:05.202] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:05.202] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:42:0) after 1m0s
[11:01:05.382] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:42:0)
[11:01:05.382] Timer tick, asking Buildbucket for the build status
[11:01:05.672] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:05.672] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:43:0) after 1m0s
[11:02:05.717] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:43:0)
[11:02:05.717] Timer tick, asking Buildbucket for the build status
[11:02:05.803] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:05.803] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:44:0) after 1m0s
[11:03:05.830] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:44:0)
[11:03:05.830] Timer tick, asking Buildbucket for the build status
[11:03:06.057] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:06.057] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:45:0) after 1m0s
[11:04:06.089] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:45:0)
[11:04:06.089] Timer tick, asking Buildbucket for the build status
[11:04:06.392] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:06.392] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:46:0) after 1m0s
[11:05:06.414] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:46:0)
[11:05:06.414] Timer tick, asking Buildbucket for the build status
[11:05:06.479] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:06.479] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:47:0) after 1m0s
[11:06:06.539] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:47:0)
[11:06:06.539] Timer tick, asking Buildbucket for the build status
[11:06:06.650] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:06.650] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:48:0) after 1m0s
[11:07:06.729] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:48:0)
[11:07:06.729] Timer tick, asking Buildbucket for the build status
[11:07:07.244] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:07.244] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:49:0) after 1m0s
[11:08:07.271] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:49:0)
[11:08:07.271] Timer tick, asking Buildbucket for the build status
[11:08:07.368] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:07.368] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:50:0) after 1m0s
[11:09:07.423] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:50:0)
[11:09:07.423] Timer tick, asking Buildbucket for the build status
[11:09:07.724] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:07.724] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:51:0) after 1m0s
[11:10:08.099] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:51:0)
[11:10:08.099] Timer tick, asking Buildbucket for the build status
[11:10:08.219] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:08.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:52:0) after 1m0s
[11:11:08.944] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:52:0)
[11:11:08.944] Timer tick, asking Buildbucket for the build status
[11:11:09.099] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:09.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:53:0) after 1m0s
[11:12:09.222] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:53:0)
[11:12:09.222] Timer tick, asking Buildbucket for the build status
[11:12:09.290] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:09.290] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:54:0) after 1m0s
[11:13:09.452] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:54:0)
[11:13:09.452] Timer tick, asking Buildbucket for the build status
[11:13:09.701] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:09.701] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:55:0) after 1m0s
[11:14:09.852] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:55:0)
[11:14:09.852] Timer tick, asking Buildbucket for the build status
[11:14:09.918] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:09.918] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:56:0) after 1m0s
[11:15:09.995] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:56:0)
[11:15:09.995] Timer tick, asking Buildbucket for the build status
[11:15:10.068] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:10.068] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:57:0) after 1m0s
[11:16:10.287] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:57:0)
[11:16:10.287] Timer tick, asking Buildbucket for the build status
[11:16:10.486] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:10.486] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:58:0) after 1m0s
[11:17:10.565] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:58:0)
[11:17:10.565] Timer tick, asking Buildbucket for the build status
[11:17:10.638] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:10.638] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:59:0) after 1m0s
[11:18:10.871] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:59:0)
[11:18:10.871] Timer tick, asking Buildbucket for the build status
[11:18:11.012] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:11.012] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:60:0) after 1m0s
[11:19:11.169] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:60:0)
[11:19:11.169] Timer tick, asking Buildbucket for the build status
[11:19:11.352] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:11.352] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:61:0) after 1m0s
[11:20:11.527] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:61:0)
[11:20:11.527] Timer tick, asking Buildbucket for the build status
[11:20:11.682] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:11.682] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:62:0) after 1m0s
[11:21:11.796] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:62:0)
[11:21:11.796] Timer tick, asking Buildbucket for the build status
[11:21:12.163] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:12.163] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:63:0) after 1m0s
[11:22:12.193] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:63:0)
[11:22:12.193] Timer tick, asking Buildbucket for the build status
[11:22:12.296] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:12.296] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:64:0) after 1m0s
[11:23:12.462] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:64:0)
[11:23:12.462] Timer tick, asking Buildbucket for the build status
[11:23:13.009] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:13.009] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:65:0) after 1m0s
[11:24:13.034] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:65:0)
[11:24:13.034] Timer tick, asking Buildbucket for the build status
[11:24:13.264] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:13.264] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:66:0) after 1m0s
[11:25:13.301] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:66:0)
[11:25:13.301] Timer tick, asking Buildbucket for the build status
[11:25:13.383] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:13.383] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:67:0) after 1m0s
[11:26:13.485] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:67:0)
[11:26:13.485] Timer tick, asking Buildbucket for the build status
[11:26:14.088] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:14.088] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:68:0) after 1m0s
[11:27:14.114] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:68:0)
[11:27:14.114] Timer tick, asking Buildbucket for the build status
[11:27:14.186] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:14.186] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:69:0) after 1m0s
[11:28:14.271] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:69:0)
[11:28:14.271] Timer tick, asking Buildbucket for the build status
[11:28:14.335] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:14.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:70:0) after 1m0s
[11:29:14.421] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:70:0)
[11:29:14.421] Timer tick, asking Buildbucket for the build status
[11:29:14.481] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:14.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:71:0) after 1m0s
[11:30:14.537] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:71:0)
[11:30:14.537] Timer tick, asking Buildbucket for the build status
[11:30:14.823] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:14.824] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:72:0) after 1m0s
[11:31:14.859] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:72:0)
[11:31:14.859] Timer tick, asking Buildbucket for the build status
[11:31:15.179] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:15.179] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:73:0) after 1m0s
[11:32:15.242] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:73:0)
[11:32:15.242] Timer tick, asking Buildbucket for the build status
[11:32:15.572] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:15.572] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:74:0) after 1m0s
[11:33:15.686] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:74:0)
[11:33:15.686] Timer tick, asking Buildbucket for the build status
[11:33:15.756] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:15.756] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:75:0) after 1m0s
[11:34:15.785] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:75:0)
[11:34:15.785] Timer tick, asking Buildbucket for the build status
[11:34:16.098] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:16.098] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:76:0) after 1m0s
[11:35:16.230] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:76:0)
[11:35:16.230] Timer tick, asking Buildbucket for the build status
[11:35:16.439] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:16.439] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:77:0) after 1m0s
[11:36:16.539] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:77:0)
[11:36:16.539] Timer tick, asking Buildbucket for the build status
[11:36:16.868] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:16.868] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:78:0) after 1m0s
[11:37:16.909] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:78:0)
[11:37:16.909] Timer tick, asking Buildbucket for the build status
[11:37:17.098] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:17.098] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:79:0) after 1m0s
[11:38:17.131] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:79:0)
[11:38:17.131] Timer tick, asking Buildbucket for the build status
[11:38:17.247] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:17.247] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:80:0) after 1m0s
[11:39:17.270] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:80:0)
[11:39:17.270] Timer tick, asking Buildbucket for the build status
[11:39:17.347] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:17.347] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:81:0) after 1m0s
[11:40:17.381] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:81:0)
[11:40:17.381] Timer tick, asking Buildbucket for the build status
[11:40:17.462] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:17.462] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:82:0) after 1m0s
[11:41:17.511] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:82:0)
[11:41:17.511] Timer tick, asking Buildbucket for the build status
[11:41:24.508] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:24.508] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:83:0) after 1m0s
[11:42:24.567] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:83:0)
[11:42:24.567] Timer tick, asking Buildbucket for the build status
[11:42:24.630] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:24.630] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:84:0) after 1m0s
[11:43:24.652] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:84:0)
[11:43:24.652] Timer tick, asking Buildbucket for the build status
[11:43:24.723] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:24.723] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:85:0) after 1m0s
[11:44:24.730] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:85:0)
[11:44:24.730] Timer tick, asking Buildbucket for the build status
[11:44:24.798] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:24.798] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:86:0) after 1m0s
[11:45:24.852] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:86:0)
[11:45:24.852] Timer tick, asking Buildbucket for the build status
[11:45:24.921] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:24.921] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:87:0) after 1m0s
[11:46:25.135] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:87:0)
[11:46:25.135] Timer tick, asking Buildbucket for the build status
[11:46:25.437] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:25.437] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:88:0) after 1m0s
[11:47:25.476] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:88:0)
[11:47:25.476] Timer tick, asking Buildbucket for the build status
[11:47:25.554] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:25.554] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:89:0) after 1m0s
[11:48:25.671] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:89:0)
[11:48:25.671] Timer tick, asking Buildbucket for the build status
[11:48:25.741] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:25.741] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:90:0) after 1m0s
[11:49:25.783] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:90:0)
[11:49:25.783] Timer tick, asking Buildbucket for the build status
[11:49:25.848] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:25.849] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:91:0) after 1m0s
[11:50:25.940] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:91:0)
[11:50:25.940] Timer tick, asking Buildbucket for the build status
[11:50:26.164] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:26.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:92:0) after 1m0s
[11:51:26.188] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:92:0)
[11:51:26.188] Timer tick, asking Buildbucket for the build status
[11:51:26.306] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:26.306] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:93:0) after 1m0s
[11:52:26.392] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:93:0)
[11:52:26.392] Timer tick, asking Buildbucket for the build status
[11:52:27.548] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:27.548] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:94:0) after 1m0s
[11:53:27.570] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:94:0)
[11:53:27.570] Timer tick, asking Buildbucket for the build status
[11:53:27.657] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:27.657] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:95:0) after 1m0s
[11:54:27.680] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:95:0)
[11:54:27.680] Timer tick, asking Buildbucket for the build status
[11:54:27.732] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:27.732] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:96:0) after 1m0s
[11:55:27.776] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:96:0)
[11:55:27.776] Timer tick, asking Buildbucket for the build status
[11:55:27.866] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:27.866] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:97:0) after 1m0s
[11:56:27.912] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:97:0)
[11:56:27.912] Timer tick, asking Buildbucket for the build status
[11:56:28.389] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:28.389] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:98:0) after 1m0s
[11:57:28.422] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:98:0)
[11:57:28.422] Timer tick, asking Buildbucket for the build status
[11:57:28.584] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:28.584] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:99:0) after 1m0s
[11:58:28.978] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:99:0)
[11:58:28.978] Timer tick, asking Buildbucket for the build status
[11:58:29.107] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:29.107] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:100:0) after 1m0s
[11:59:30.831] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:100:0)
[11:59:30.831] Timer tick, asking Buildbucket for the build status
[11:59:31.114] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:31.114] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:101:0) after 1m0s
[12:00:31.386] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:101:0)
[12:00:31.386] Timer tick, asking Buildbucket for the build status
[12:00:31.504] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:31.504] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:102:0) after 1m0s
[12:01:31.715] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:102:0)
[12:01:31.715] Timer tick, asking Buildbucket for the build status
[12:01:32.193] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:32.194] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:103:0) after 1m0s
[12:02:32.295] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:103:0)
[12:02:32.295] Timer tick, asking Buildbucket for the build status
[12:02:32.371] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:32.371] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:104:0) after 1m0s
[12:03:32.623] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:104:0)
[12:03:32.624] Timer tick, asking Buildbucket for the build status
[12:03:32.709] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:32.709] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:105:0) after 1m0s
[12:04:33.053] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:105:0)
[12:04:33.053] Timer tick, asking Buildbucket for the build status
[12:04:33.126] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:33.126] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:106:0) after 1m0s
[12:05:33.348] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:106:0)
[12:05:33.348] Timer tick, asking Buildbucket for the build status
[12:05:33.423] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:33.423] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:107:0) after 1m0s
[12:06:33.631] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:107:0)
[12:06:33.631] Timer tick, asking Buildbucket for the build status
[12:06:33.833] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:33.833] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:108:0) after 1m0s
[12:07:34.225] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:108:0)
[12:07:34.225] Timer tick, asking Buildbucket for the build status
[12:07:34.455] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:34.455] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:109:0) after 1m0s
[12:08:34.449] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:109:0)
[12:08:34.449] Timer tick, asking Buildbucket for the build status
[12:08:34.534] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:34.534] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:110:0) after 1m0s
[12:09:34.613] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:110:0)
[12:09:34.613] Timer tick, asking Buildbucket for the build status
[12:09:34.686] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:34.686] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:111:0) after 1m0s
[12:10:34.909] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:111:0)
[12:10:34.909] Timer tick, asking Buildbucket for the build status
[12:10:35.047] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:35.047] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:112:0) after 1m0s
[12:11:35.103] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:112:0)
[12:11:35.103] Timer tick, asking Buildbucket for the build status
[12:11:35.204] Build 8863300627103600768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:35.204] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9028730689459333456:113:0) after 1m0s
[12:11:48.260] Received PubSub notification, asking Buildbucket for the build status
[12:11:48.337] Build 8863300627103600768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:11:48.337] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1605701506004957",
"created_by": "project:r8",
"created_ts": "1605694855551306",
"id": "8863300627103600768",
"parameters_json": "{\"builder_name\": \"linux-jdk8\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\", \"title\": \"8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\", \"url\": \"https://r8.googlesource.com/r8/+/8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"297c09826f16bb9080cbd94b612570d55113e280\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@297c09826f16bb9080cbd94b612570d55113e280\", \"title\": \"297c09826f16bb9080cbd94b612570d55113e280\", \"url\": \"https://r8.googlesource.com/r8/+/297c09826f16bb9080cbd94b612570d55113e280\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"297c09826f16bb9080cbd94b612570d55113e280\"}}",
"project": "r8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\", \"title\": \"8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\", \"url\": \"https://r8.googlesource.com/r8/+/8e6cf9af137f0f95da4d3f5eccd6d75a71b2691c\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"297c09826f16bb9080cbd94b612570d55113e280\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@297c09826f16bb9080cbd94b612570d55113e280\", \"title\": \"297c09826f16bb9080cbd94b612570d55113e280\", \"url\": \"https://r8.googlesource.com/r8/+/297c09826f16bb9080cbd94b612570d55113e280\"}]}, \"bot_id\": \"luci-r8-custom-ci-xenial-21-d9az\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-jdk8\", \"buildnumber\": 163, \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"297c09826f16bb9080cbd94b612570d55113e280\", \"test_options\": [\"--runtimes=jdk8\", \"--no_internal\", \"--one_line_per_test\", \"--archive_failures\"]}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_535ad7637a04c3e27d1496cee679fa117c96e8656eac01642dd379313c9a8210_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"r8bot-265908\"], \"gpu\": [\"none\"], \"id\": [\"luci-r8-custom-ci-xenial-21-d9az\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"normal\": [\"true\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.r8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5635-1756fdb\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605694888443390",
"status": "COMPLETED",
"status_changed_ts": "1605701506935027",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/163",
"builder:linux-jdk8",
"buildset:commit/git/297c09826f16bb9080cbd94b612570d55113e280",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/297c09826f16bb9080cbd94b612570d55113e280",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028730689459333456",
"scheduler_job_id:r8/linux-jdk8",
"swarming_hostname:chrome-swarming.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/r8/buildbucket/cr-buildbucket.appspot.com/8863300627103600768/+/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:4ff3b0a5ca189c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605701507511886",
"url": "https://ci.chromium.org/b/8863300627103600768",
"utcnow_ts": "1605701508328230"
}
}
[12:11:48.337] Invocation finished in 1h50m54.415242908s with status SUCCEEDED