[17:00:29.545] New invocation is queued and will start shortly
[17:00:30.821] Starting the invocation (attempt 1)
[17:00:30.896] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:00:30.896] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:00:30.896] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9029249131013566528",
"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\":\"fe2aa7b1d0ab09e7413612a94885f775da0d9153\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@fe2aa7b1d0ab09e7413612a94885f775da0d9153\",\"title\":\"fe2aa7b1d0ab09e7413612a94885f775da0d9153\",\"url\":\"https://r8.googlesource.com/r8/+/fe2aa7b1d0ab09e7413612a94885f775da0d9153\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"fe2aa7b1d0ab09e7413612a94885f775da0d9153\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-jdk8",
"scheduler_invocation_id:9029249131013566528",
"scheduler_job_id:r8/linux-jdk8",
"user_agent:luci-scheduler",
"buildset:commit/git/fe2aa7b1d0ab09e7413612a94885f775da0d9153",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/fe2aa7b1d0ab09e7413612a94885f775da0d9153",
"gitiles_ref:refs/heads/master"
]
}
[17:00:32.163] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:r8",
"created_ts": "1605200431116459",
"id": "8863819068699905504",
"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\": \"fe2aa7b1d0ab09e7413612a94885f775da0d9153\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@fe2aa7b1d0ab09e7413612a94885f775da0d9153\", \"title\": \"fe2aa7b1d0ab09e7413612a94885f775da0d9153\", \"url\": \"https://r8.googlesource.com/r8/+/fe2aa7b1d0ab09e7413612a94885f775da0d9153\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"fe2aa7b1d0ab09e7413612a94885f775da0d9153\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605200431945320",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/133",
"builder:linux-jdk8",
"buildset:commit/git/fe2aa7b1d0ab09e7413612a94885f775da0d9153",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/fe2aa7b1d0ab09e7413612a94885f775da0d9153",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029249131013566528",
"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/8863819068699905504/+/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": "1605200431945478",
"url": "https://ci.chromium.org/b/8863819068699905504",
"utcnow_ts": "1605200432144376"
}
}
[17:00:32.163] Task URL: https://ci.chromium.org/b/8863819068699905504
[17:00:32.163] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:2:0) after 1m0s
[17:01:32.244] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:2:0)
[17:01:32.244] Timer tick, asking Buildbucket for the build status
[17:01:32.374] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:01:32.375] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:3:0) after 1m0s
[17:02:32.581] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:3:0)
[17:02:32.581] Timer tick, asking Buildbucket for the build status
[17:02:32.662] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:02:32.662] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:4:0) after 1m0s
[17:03:32.767] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:4:0)
[17:03:32.767] Timer tick, asking Buildbucket for the build status
[17:03:32.975] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:03:32.975] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:5:0) after 1m0s
[17:04:32.966] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:5:0)
[17:04:32.966] Timer tick, asking Buildbucket for the build status
[17:04:33.134] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:04:33.134] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:6:0) after 1m0s
[17:05:33.208] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:6:0)
[17:05:33.208] Timer tick, asking Buildbucket for the build status
[17:05:33.393] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:05:33.393] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:7:0) after 1m0s
[17:06:33.485] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:7:0)
[17:06:33.485] Timer tick, asking Buildbucket for the build status
[17:06:33.644] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:06:33.644] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:8:0) after 1m0s
[17:07:34.085] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:8:0)
[17:07:34.085] Timer tick, asking Buildbucket for the build status
[17:07:34.473] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:07:34.473] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:9:0) after 1m0s
[17:08:34.659] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:9:0)
[17:08:34.659] Timer tick, asking Buildbucket for the build status
[17:08:34.737] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:08:34.737] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:10:0) after 1m0s
[17:09:34.969] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:10:0)
[17:09:34.969] Timer tick, asking Buildbucket for the build status
[17:09:36.423] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:09:36.423] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:11:0) after 1m0s
[17:10:36.670] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:11:0)
[17:10:36.670] Timer tick, asking Buildbucket for the build status
[17:10:36.777] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:10:36.777] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:12:0) after 1m0s
[17:11:36.825] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:12:0)
[17:11:36.825] Timer tick, asking Buildbucket for the build status
[17:11:36.939] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:11:36.939] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:13:0) after 1m0s
[17:12:36.926] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:13:0)
[17:12:36.926] Timer tick, asking Buildbucket for the build status
[17:12:37.026] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:12:37.026] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:14:0) after 1m0s
[17:13:37.085] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:14:0)
[17:13:37.085] Timer tick, asking Buildbucket for the build status
[17:13:44.198] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:13:44.198] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:15:0) after 1m0s
[17:14:44.274] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:15:0)
[17:14:44.274] Timer tick, asking Buildbucket for the build status
[17:14:44.949] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:14:44.949] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:16:0) after 1m0s
[17:15:45.048] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:16:0)
[17:15:45.048] Timer tick, asking Buildbucket for the build status
[17:15:45.160] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:15:45.160] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:17:0) after 1m0s
[17:16:45.236] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:17:0)
[17:16:45.236] Timer tick, asking Buildbucket for the build status
[17:16:45.814] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:16:45.814] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:18:0) after 1m0s
[17:17:45.812] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:18:0)
[17:17:45.812] Timer tick, asking Buildbucket for the build status
[17:17:45.891] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:17:45.891] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:19:0) after 1m0s
[17:18:45.978] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:19:0)
[17:18:45.978] Timer tick, asking Buildbucket for the build status
[17:18:46.064] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:18:46.064] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:20:0) after 1m0s
[17:19:46.127] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:20:0)
[17:19:46.127] Timer tick, asking Buildbucket for the build status
[17:19:46.206] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:19:46.206] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:21:0) after 1m0s
[17:20:46.201] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:21:0)
[17:20:46.201] Timer tick, asking Buildbucket for the build status
[17:20:46.322] Build 8863819068699905504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:20:46.322] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:22:0) after 1m0s
[17:21:19.352] Received PubSub notification, asking Buildbucket for the build status
[17:21:19.604] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:46.387] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:22:0)
[17:21:46.387] Timer tick, asking Buildbucket for the build status
[17:21:46.522] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:46.522] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:24:0) after 1m0s
[17:22:46.546] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:24:0)
[17:22:46.546] Timer tick, asking Buildbucket for the build status
[17:22:46.835] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:46.835] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:25:0) after 1m0s
[17:23:46.920] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:25:0)
[17:23:46.920] Timer tick, asking Buildbucket for the build status
[17:23:47.409] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:47.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:26:0) after 1m0s
[17:24:47.440] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:26:0)
[17:24:47.440] Timer tick, asking Buildbucket for the build status
[17:24:47.522] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:47.522] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:27:0) after 1m0s
[17:25:47.602] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:27:0)
[17:25:47.602] Timer tick, asking Buildbucket for the build status
[17:25:48.001] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:48.001] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:28:0) after 1m0s
[17:26:48.035] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:28:0)
[17:26:48.035] Timer tick, asking Buildbucket for the build status
[17:26:48.268] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:48.268] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:29:0) after 1m0s
[17:27:48.321] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:29:0)
[17:27:48.321] Timer tick, asking Buildbucket for the build status
[17:27:48.553] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:48.553] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:30:0) after 1m0s
[17:28:48.690] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:30:0)
[17:28:48.690] Timer tick, asking Buildbucket for the build status
[17:28:48.833] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:48.833] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:31:0) after 1m0s
[17:29:48.854] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:31:0)
[17:29:48.855] Timer tick, asking Buildbucket for the build status
[17:29:48.954] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:48.954] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:32:0) after 1m0s
[17:30:48.978] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:32:0)
[17:30:48.978] Timer tick, asking Buildbucket for the build status
[17:30:49.395] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:49.395] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:33:0) after 1m0s
[17:31:49.407] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:33:0)
[17:31:49.407] Timer tick, asking Buildbucket for the build status
[17:31:49.513] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:49.514] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:34:0) after 1m0s
[17:32:49.584] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:34:0)
[17:32:49.584] Timer tick, asking Buildbucket for the build status
[17:32:49.667] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:49.667] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:35:0) after 1m0s
[17:33:49.689] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:35:0)
[17:33:49.689] Timer tick, asking Buildbucket for the build status
[17:33:50.106] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:50.106] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:36:0) after 1m0s
[17:34:50.133] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:36:0)
[17:34:50.133] Timer tick, asking Buildbucket for the build status
[17:34:50.401] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:50.401] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:37:0) after 1m0s
[17:35:50.498] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:37:0)
[17:35:50.498] Timer tick, asking Buildbucket for the build status
[17:35:50.996] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:50.996] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:38:0) after 1m0s
[17:36:51.055] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:38:0)
[17:36:51.055] Timer tick, asking Buildbucket for the build status
[17:36:51.138] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:51.138] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:39:0) after 1m0s
[17:37:51.248] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:39:0)
[17:37:51.248] Timer tick, asking Buildbucket for the build status
[17:37:51.348] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:51.348] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:40:0) after 1m0s
[17:38:51.403] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:40:0)
[17:38:51.403] Timer tick, asking Buildbucket for the build status
[17:38:51.481] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:51.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:41:0) after 1m0s
[17:39:51.527] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:41:0)
[17:39:51.527] Timer tick, asking Buildbucket for the build status
[17:39:51.889] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:51.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:42:0) after 1m0s
[17:40:51.933] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:42:0)
[17:40:51.933] Timer tick, asking Buildbucket for the build status
[17:40:53.346] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:53.346] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:43:0) after 1m0s
[17:41:53.388] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:43:0)
[17:41:53.388] Timer tick, asking Buildbucket for the build status
[17:41:53.477] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:53.477] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:44:0) after 1m0s
[17:42:53.497] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:44:0)
[17:42:53.497] Timer tick, asking Buildbucket for the build status
[17:42:53.616] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:53.616] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:45:0) after 1m0s
[17:43:53.653] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:45:0)
[17:43:53.653] Timer tick, asking Buildbucket for the build status
[17:43:54.225] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:54.225] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:46:0) after 1m0s
[17:44:54.267] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:46:0)
[17:44:54.267] Timer tick, asking Buildbucket for the build status
[17:44:54.527] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:54.527] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:47:0) after 1m0s
[17:45:54.599] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:47:0)
[17:45:54.599] Timer tick, asking Buildbucket for the build status
[17:45:55.421] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:55.421] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:48:0) after 1m0s
[17:46:55.482] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:48:0)
[17:46:55.482] Timer tick, asking Buildbucket for the build status
[17:46:55.826] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:55.826] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:49:0) after 1m0s
[17:47:55.854] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:49:0)
[17:47:55.854] Timer tick, asking Buildbucket for the build status
[17:47:56.236] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:56.236] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:50:0) after 1m0s
[17:48:56.279] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:50:0)
[17:48:56.279] Timer tick, asking Buildbucket for the build status
[17:48:56.347] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:56.347] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:51:0) after 1m0s
[17:49:56.348] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:51:0)
[17:49:56.348] Timer tick, asking Buildbucket for the build status
[17:49:56.415] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:56.415] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:52:0) after 1m0s
[17:50:56.480] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:52:0)
[17:50:56.480] Timer tick, asking Buildbucket for the build status
[17:50:56.979] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:56.979] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:53:0) after 1m0s
[17:51:57.006] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:53:0)
[17:51:57.006] Timer tick, asking Buildbucket for the build status
[17:51:57.085] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:57.085] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:54:0) after 1m0s
[17:52:57.116] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:54:0)
[17:52:57.116] Timer tick, asking Buildbucket for the build status
[17:52:57.195] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:57.195] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:55:0) after 1m0s
[17:53:57.261] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:55:0)
[17:53:57.261] Timer tick, asking Buildbucket for the build status
[17:53:57.327] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:57.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:56:0) after 1m0s
[17:54:57.390] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:56:0)
[17:54:57.390] Timer tick, asking Buildbucket for the build status
[17:54:57.470] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:57.470] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:57:0) after 1m0s
[17:55:57.796] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:57:0)
[17:55:57.796] Timer tick, asking Buildbucket for the build status
[17:55:57.915] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:57.915] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:58:0) after 1m0s
[17:56:58.101] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:58:0)
[17:56:58.101] Timer tick, asking Buildbucket for the build status
[17:56:58.653] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:58.653] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:59:0) after 1m0s
[17:57:58.686] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:59:0)
[17:57:58.686] Timer tick, asking Buildbucket for the build status
[17:57:59.204] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:59.204] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:60:0) after 1m0s
[17:58:59.243] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:60:0)
[17:58:59.243] Timer tick, asking Buildbucket for the build status
[17:58:59.486] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:59.486] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:61:0) after 1m0s
[17:59:59.509] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:61:0)
[17:59:59.509] Timer tick, asking Buildbucket for the build status
[17:59:59.591] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:59.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:62:0) after 1m0s
[18:00:59.728] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:62:0)
[18:00:59.728] Timer tick, asking Buildbucket for the build status
[18:00:59.855] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:59.855] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:63:0) after 1m0s
[18:02:00.020] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:63:0)
[18:02:00.020] Timer tick, asking Buildbucket for the build status
[18:02:00.370] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:00.370] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:64:0) after 1m0s
[18:03:00.553] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:64:0)
[18:03:00.553] Timer tick, asking Buildbucket for the build status
[18:03:01.135] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:01.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:65:0) after 1m0s
[18:04:04.729] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:65:0)
[18:04:04.729] Timer tick, asking Buildbucket for the build status
[18:04:05.037] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:05.038] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:66:0) after 1m0s
[18:05:05.572] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:66:0)
[18:05:05.572] Timer tick, asking Buildbucket for the build status
[18:05:06.034] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:06.034] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:67:0) after 1m0s
[18:06:06.148] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:67:0)
[18:06:06.148] Timer tick, asking Buildbucket for the build status
[18:06:06.943] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:06.943] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:68:0) after 1m0s
[18:07:07.068] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:68:0)
[18:07:07.068] Timer tick, asking Buildbucket for the build status
[18:07:07.162] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:07.162] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:69:0) after 1m0s
[18:08:07.242] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:69:0)
[18:08:07.242] Timer tick, asking Buildbucket for the build status
[18:08:07.781] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:07.781] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:70:0) after 1m0s
[18:09:07.920] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:70:0)
[18:09:07.920] Timer tick, asking Buildbucket for the build status
[18:09:08.407] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:08.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:71:0) after 1m0s
[18:10:08.565] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:71:0)
[18:10:08.565] Timer tick, asking Buildbucket for the build status
[18:10:08.669] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:08.669] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:72:0) after 1m0s
[18:11:08.758] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:72:0)
[18:11:08.758] Timer tick, asking Buildbucket for the build status
[18:11:08.883] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:08.883] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:73:0) after 1m0s
[18:12:08.929] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:73:0)
[18:12:08.929] Timer tick, asking Buildbucket for the build status
[18:12:09.048] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:09.048] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:74:0) after 1m0s
[18:13:09.063] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:74:0)
[18:13:09.063] Timer tick, asking Buildbucket for the build status
[18:13:09.474] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:09.474] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:75:0) after 1m0s
[18:14:09.541] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:75:0)
[18:14:09.541] Timer tick, asking Buildbucket for the build status
[18:14:10.674] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:10.674] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:76:0) after 1m0s
[18:15:10.787] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:76:0)
[18:15:10.788] Timer tick, asking Buildbucket for the build status
[18:15:10.993] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:10.993] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:77:0) after 1m0s
[18:16:11.117] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:77:0)
[18:16:11.117] Timer tick, asking Buildbucket for the build status
[18:16:11.367] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:11.367] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:78:0) after 1m0s
[18:17:11.395] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:78:0)
[18:17:11.395] Timer tick, asking Buildbucket for the build status
[18:17:11.532] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:11.532] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:79:0) after 1m0s
[18:18:11.546] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:79:0)
[18:18:11.546] Timer tick, asking Buildbucket for the build status
[18:18:11.624] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:11.624] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:80:0) after 1m0s
[18:19:11.691] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:80:0)
[18:19:11.691] Timer tick, asking Buildbucket for the build status
[18:19:11.975] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:11.976] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:81:0) after 1m0s
[18:20:12.049] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:81:0)
[18:20:12.049] Timer tick, asking Buildbucket for the build status
[18:20:12.135] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:12.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:82:0) after 1m0s
[18:21:12.150] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:82:0)
[18:21:12.150] Timer tick, asking Buildbucket for the build status
[18:21:12.269] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:12.269] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:83:0) after 1m0s
[18:22:12.320] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:83:0)
[18:22:12.320] Timer tick, asking Buildbucket for the build status
[18:22:12.388] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:12.388] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:84:0) after 1m0s
[18:23:12.473] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:84:0)
[18:23:12.473] Timer tick, asking Buildbucket for the build status
[18:23:12.586] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:12.586] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:85:0) after 1m0s
[18:24:12.669] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:85:0)
[18:24:12.669] Timer tick, asking Buildbucket for the build status
[18:24:12.767] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:12.768] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:86:0) after 1m0s
[18:25:12.819] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:86:0)
[18:25:12.819] Timer tick, asking Buildbucket for the build status
[18:25:12.881] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:12.881] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:87:0) after 1m0s
[18:26:12.993] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:87:0)
[18:26:12.993] Timer tick, asking Buildbucket for the build status
[18:26:13.184] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:13.184] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:88:0) after 1m0s
[18:27:13.281] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:88:0)
[18:27:13.281] Timer tick, asking Buildbucket for the build status
[18:27:13.348] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:13.348] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:89:0) after 1m0s
[18:28:13.411] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:89:0)
[18:28:13.411] Timer tick, asking Buildbucket for the build status
[18:28:13.564] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:13.564] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:90:0) after 1m0s
[18:29:13.603] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:90:0)
[18:29:13.603] Timer tick, asking Buildbucket for the build status
[18:29:13.748] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:13.748] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:91:0) after 1m0s
[18:30:13.767] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:91:0)
[18:30:13.767] Timer tick, asking Buildbucket for the build status
[18:30:14.117] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:14.117] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:92:0) after 1m0s
[18:31:14.220] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:92:0)
[18:31:14.220] Timer tick, asking Buildbucket for the build status
[18:31:14.611] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:14.611] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:93:0) after 1m0s
[18:32:14.626] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:93:0)
[18:32:14.626] Timer tick, asking Buildbucket for the build status
[18:32:14.848] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:14.848] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:94:0) after 1m0s
[18:33:14.847] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:94:0)
[18:33:14.847] Timer tick, asking Buildbucket for the build status
[18:33:14.921] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:14.921] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:95:0) after 1m0s
[18:34:14.959] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:95:0)
[18:34:14.959] Timer tick, asking Buildbucket for the build status
[18:34:15.052] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:15.052] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:96:0) after 1m0s
[18:35:15.108] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:96:0)
[18:35:15.108] Timer tick, asking Buildbucket for the build status
[18:35:15.174] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:15.174] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:97:0) after 1m0s
[18:36:15.252] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:97:0)
[18:36:15.252] Timer tick, asking Buildbucket for the build status
[18:36:15.404] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:15.404] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:98:0) after 1m0s
[18:37:15.481] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:98:0)
[18:37:15.481] Timer tick, asking Buildbucket for the build status
[18:37:15.592] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:15.592] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:99:0) after 1m0s
[18:38:15.728] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:99:0)
[18:38:15.728] Timer tick, asking Buildbucket for the build status
[18:38:15.875] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:15.875] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:100:0) after 1m0s
[18:39:15.943] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:100:0)
[18:39:15.943] Timer tick, asking Buildbucket for the build status
[18:39:16.306] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:16.306] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:101:0) after 1m0s
[18:40:16.445] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:101:0)
[18:40:16.445] Timer tick, asking Buildbucket for the build status
[18:40:16.672] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:16.672] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:102:0) after 1m0s
[18:41:16.822] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:102:0)
[18:41:16.822] Timer tick, asking Buildbucket for the build status
[18:41:17.008] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:17.008] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:103:0) after 1m0s
[18:42:17.051] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:103:0)
[18:42:17.051] Timer tick, asking Buildbucket for the build status
[18:42:17.203] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:17.203] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:104:0) after 1m0s
[18:43:17.265] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:104:0)
[18:43:17.265] Timer tick, asking Buildbucket for the build status
[18:43:17.345] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:17.345] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:105:0) after 1m0s
[18:44:17.390] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:105:0)
[18:44:17.390] Timer tick, asking Buildbucket for the build status
[18:44:17.548] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:17.548] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:106:0) after 1m0s
[18:45:17.606] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:106:0)
[18:45:17.606] Timer tick, asking Buildbucket for the build status
[18:45:17.705] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:17.705] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:107:0) after 1m0s
[18:46:17.698] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:107:0)
[18:46:17.698] Timer tick, asking Buildbucket for the build status
[18:46:17.815] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:17.815] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:108:0) after 1m0s
[18:47:17.867] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:108:0)
[18:47:17.867] Timer tick, asking Buildbucket for the build status
[18:47:18.488] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:18.488] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:109:0) after 1m0s
[18:48:18.587] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:109:0)
[18:48:18.587] Timer tick, asking Buildbucket for the build status
[18:48:19.102] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:19.102] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:110:0) after 1m0s
[18:49:19.157] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:110:0)
[18:49:19.157] Timer tick, asking Buildbucket for the build status
[18:49:19.355] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:19.355] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:111:0) after 1m0s
[18:50:19.383] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:111:0)
[18:50:19.383] Timer tick, asking Buildbucket for the build status
[18:50:19.464] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:19.464] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:112:0) after 1m0s
[18:51:19.656] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:112:0)
[18:51:19.656] Timer tick, asking Buildbucket for the build status
[18:51:19.770] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:19.770] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:113:0) after 1m0s
[18:52:19.878] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:113:0)
[18:52:19.878] Timer tick, asking Buildbucket for the build status
[18:52:19.952] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:19.952] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:114:0) after 1m0s
[18:53:19.989] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:114:0)
[18:53:19.989] Timer tick, asking Buildbucket for the build status
[18:53:20.091] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:20.091] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:115:0) after 1m0s
[18:54:20.146] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:115:0)
[18:54:20.146] Timer tick, asking Buildbucket for the build status
[18:54:20.226] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:20.226] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:116:0) after 1m0s
[18:55:20.330] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:116:0)
[18:55:20.330] Timer tick, asking Buildbucket for the build status
[18:55:20.804] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:20.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:117:0) after 1m0s
[18:56:20.837] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:117:0)
[18:56:20.837] Timer tick, asking Buildbucket for the build status
[18:56:20.963] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:20.963] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:118:0) after 1m0s
[18:57:21.118] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:118:0)
[18:57:21.118] Timer tick, asking Buildbucket for the build status
[18:57:21.223] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:21.223] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:119:0) after 1m0s
[18:58:21.248] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:119:0)
[18:58:21.248] Timer tick, asking Buildbucket for the build status
[18:58:21.331] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:21.331] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:120:0) after 1m0s
[18:59:21.378] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:120:0)
[18:59:21.378] Timer tick, asking Buildbucket for the build status
[18:59:21.581] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:21.581] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:121:0) after 1m0s
[19:00:21.692] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:121:0)
[19:00:21.692] Timer tick, asking Buildbucket for the build status
[19:00:21.801] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:21.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:122:0) after 1m0s
[19:01:21.862] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:122:0)
[19:01:21.862] Timer tick, asking Buildbucket for the build status
[19:01:22.336] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:22.336] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:123:0) after 1m0s
[19:02:22.521] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:123:0)
[19:02:22.521] Timer tick, asking Buildbucket for the build status
[19:02:22.628] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:22.628] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:124:0) after 1m0s
[19:03:22.734] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:124:0)
[19:03:22.734] Timer tick, asking Buildbucket for the build status
[19:03:22.870] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:22.870] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:125:0) after 1m0s
[19:04:23.042] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:125:0)
[19:04:23.042] Timer tick, asking Buildbucket for the build status
[19:04:23.715] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:23.715] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:126:0) after 1m0s
[19:05:23.816] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:126:0)
[19:05:23.816] Timer tick, asking Buildbucket for the build status
[19:05:23.896] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:23.896] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:127:0) after 1m0s
[19:06:24.189] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:127:0)
[19:06:24.189] Timer tick, asking Buildbucket for the build status
[19:06:26.718] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:26.718] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:128:0) after 1m0s
[19:07:26.768] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:128:0)
[19:07:26.768] Timer tick, asking Buildbucket for the build status
[19:07:26.847] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:26.848] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:129:0) after 1m0s
[19:08:26.883] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:129:0)
[19:08:26.883] Timer tick, asking Buildbucket for the build status
[19:08:26.941] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:26.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:130:0) after 1m0s
[19:09:26.959] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:130:0)
[19:09:26.959] Timer tick, asking Buildbucket for the build status
[19:09:27.683] Build 8863819068699905504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:27.683] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029249131013566528:131:0) after 1m0s
[19:09:52.974] Received PubSub notification, asking Buildbucket for the build status
[19:09:53.099] Build 8863819068699905504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:09:53.099] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1605208191770347",
"created_by": "project:r8",
"created_ts": "1605200431116459",
"id": "8863819068699905504",
"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\": \"fe2aa7b1d0ab09e7413612a94885f775da0d9153\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@fe2aa7b1d0ab09e7413612a94885f775da0d9153\", \"title\": \"fe2aa7b1d0ab09e7413612a94885f775da0d9153\", \"url\": \"https://r8.googlesource.com/r8/+/fe2aa7b1d0ab09e7413612a94885f775da0d9153\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"fe2aa7b1d0ab09e7413612a94885f775da0d9153\"}}",
"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\": \"fe2aa7b1d0ab09e7413612a94885f775da0d9153\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@fe2aa7b1d0ab09e7413612a94885f775da0d9153\", \"title\": \"fe2aa7b1d0ab09e7413612a94885f775da0d9153\", \"url\": \"https://r8.googlesource.com/r8/+/fe2aa7b1d0ab09e7413612a94885f775da0d9153\"}]}, \"bot_id\": \"luci-r8-custom-ci-xenial-5-stuy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-jdk8\", \"buildnumber\": 133, \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"fe2aa7b1d0ab09e7413612a94885f775da0d9153\", \"test_options\": [\"--runtimes=jdk8\", \"--no_internal\", \"--one_line_per_test\", \"--archive_failures\"]}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_13abc2c167d4807f8cd9a68809b180acd05491115ae850c88abcd84f3f633393_v2\", \"builder_3c159a9b84d8f6e165b08d61c279b0bf7aa51725c8458c0d19f908398bf87fde_v2\", \"builder_9add2253e16dc8ad985b1d8f6acea5e24f87773de7e924ed59243ca04d1aea1e_v2\", \"builder_d5c43b6981f626da6d6af62097898756a96be33bfecc5c75496e349769853f9d_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-5-stuy\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605201677956948",
"status": "COMPLETED",
"status_changed_ts": "1605208192542039",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/133",
"builder:linux-jdk8",
"buildset:commit/git/fe2aa7b1d0ab09e7413612a94885f775da0d9153",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/fe2aa7b1d0ab09e7413612a94885f775da0d9153",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029249131013566528",
"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/8863819068699905504/+/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:4fd6387bb3367310",
"user_agent:luci-scheduler"
],
"updated_ts": "1605208192659091",
"url": "https://ci.chromium.org/b/8863819068699905504",
"utcnow_ts": "1605208193086521"
}
}
[19:09:53.099] Invocation finished in 2h9m23.572470429s with status SUCCEEDED