[12:22:07.918] New invocation is queued and will start shortly
[12:22:09.559] Starting the invocation (attempt 1)
[12:22:09.630] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:22:09.630] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:22:09.630] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9027635898555397552",
"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\":\"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\",\"title\":\"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\",\"url\":\"https://r8.googlesource.com/r8/+/2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-jdk8",
"scheduler_invocation_id:9027635898555397552",
"scheduler_job_id:r8/linux-jdk8",
"user_agent:luci-scheduler",
"buildset:commit/git/2d3aca6562d2a934d90b7d0390bbf3ecdb245e17",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/2d3aca6562d2a934d90b7d0390bbf3ecdb245e17",
"gitiles_ref:refs/heads/master"
]
}
[12:22:11.810] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1606738929805176",
"id": "8862205835898730592",
"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\": \"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\", \"title\": \"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\", \"url\": \"https://r8.googlesource.com/r8/+/2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606738931173786",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/223",
"builder:linux-jdk8",
"buildset:commit/git/2d3aca6562d2a934d90b7d0390bbf3ecdb245e17",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/2d3aca6562d2a934d90b7d0390bbf3ecdb245e17",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027635898555397552",
"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/8862205835898730592/+/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": "1606738931173955",
"url": "https://ci.chromium.org/b/8862205835898730592",
"utcnow_ts": "1606738931759109"
}
}
[12:22:11.810] Task URL: https://ci.chromium.org/b/8862205835898730592
[12:22:11.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:2:0) after 1m0s
[12:22:52.550] Received PubSub notification, asking Buildbucket for the build status
[12:22:52.678] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:11.968] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:2:0)
[12:23:11.968] Timer tick, asking Buildbucket for the build status
[12:23:12.141] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:12.141] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:4:0) after 1m0s
[12:24:12.152] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:4:0)
[12:24:12.152] Timer tick, asking Buildbucket for the build status
[12:24:12.629] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:12.629] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:5:0) after 1m0s
[12:25:12.654] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:5:0)
[12:25:12.654] Timer tick, asking Buildbucket for the build status
[12:25:12.725] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:12.726] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:6:0) after 1m0s
[12:26:12.732] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:6:0)
[12:26:12.732] Timer tick, asking Buildbucket for the build status
[12:26:12.805] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:12.805] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:7:0) after 1m0s
[12:27:12.893] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:7:0)
[12:27:12.893] Timer tick, asking Buildbucket for the build status
[12:27:13.279] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:13.279] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:8:0) after 1m0s
[12:28:13.370] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:8:0)
[12:28:13.370] Timer tick, asking Buildbucket for the build status
[12:28:13.504] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:13.504] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:9:0) after 1m0s
[12:29:13.544] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:9:0)
[12:29:13.544] Timer tick, asking Buildbucket for the build status
[12:29:13.813] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:13.813] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:10:0) after 1m0s
[12:30:13.852] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:10:0)
[12:30:13.852] Timer tick, asking Buildbucket for the build status
[12:30:13.994] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:13.994] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:11:0) after 1m0s
[12:31:14.047] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:11:0)
[12:31:14.047] Timer tick, asking Buildbucket for the build status
[12:31:14.161] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:14.161] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:12:0) after 1m0s
[12:32:14.181] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:12:0)
[12:32:14.181] Timer tick, asking Buildbucket for the build status
[12:32:14.378] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:14.378] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:13:0) after 1m0s
[12:33:14.440] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:13:0)
[12:33:14.440] Timer tick, asking Buildbucket for the build status
[12:33:14.921] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:14.921] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:14:0) after 1m0s
[12:34:14.929] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:14:0)
[12:34:14.929] Timer tick, asking Buildbucket for the build status
[12:34:15.000] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:15.000] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:15:0) after 1m0s
[12:35:15.027] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:15:0)
[12:35:15.027] Timer tick, asking Buildbucket for the build status
[12:35:15.149] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:15.149] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:16:0) after 1m0s
[12:36:15.251] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:16:0)
[12:36:15.251] Timer tick, asking Buildbucket for the build status
[12:36:15.393] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:15.393] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:17:0) after 1m0s
[12:37:15.433] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:17:0)
[12:37:15.433] Timer tick, asking Buildbucket for the build status
[12:37:15.838] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:15.838] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:18:0) after 1m0s
[12:38:17.488] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:18:0)
[12:38:17.488] Timer tick, asking Buildbucket for the build status
[12:38:17.711] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:17.711] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:19:0) after 1m0s
[12:39:17.729] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:19:0)
[12:39:17.729] Timer tick, asking Buildbucket for the build status
[12:39:17.943] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:17.943] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:20:0) after 1m0s
[12:40:17.978] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:20:0)
[12:40:17.978] Timer tick, asking Buildbucket for the build status
[12:40:18.261] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:18.261] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:21:0) after 1m0s
[12:41:18.297] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:21:0)
[12:41:18.297] Timer tick, asking Buildbucket for the build status
[12:41:18.357] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:18.357] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:22:0) after 1m0s
[12:42:18.402] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:22:0)
[12:42:18.402] Timer tick, asking Buildbucket for the build status
[12:42:18.507] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:18.507] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:23:0) after 1m0s
[12:43:18.557] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:23:0)
[12:43:18.557] Timer tick, asking Buildbucket for the build status
[12:43:18.617] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:18.617] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:24:0) after 1m0s
[12:44:18.712] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:24:0)
[12:44:18.712] Timer tick, asking Buildbucket for the build status
[12:44:18.779] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:18.779] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:25:0) after 1m0s
[12:45:18.842] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:25:0)
[12:45:18.842] Timer tick, asking Buildbucket for the build status
[12:45:18.957] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:18.957] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:26:0) after 1m0s
[12:46:19.025] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:26:0)
[12:46:19.025] Timer tick, asking Buildbucket for the build status
[12:46:19.156] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:19.156] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:27:0) after 1m0s
[12:47:19.232] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:27:0)
[12:47:19.232] Timer tick, asking Buildbucket for the build status
[12:47:19.441] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:19.442] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:28:0) after 1m0s
[12:48:19.497] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:28:0)
[12:48:19.497] Timer tick, asking Buildbucket for the build status
[12:48:19.567] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:19.567] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:29:0) after 1m0s
[12:49:19.598] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:29:0)
[12:49:19.598] Timer tick, asking Buildbucket for the build status
[12:49:19.652] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:19.652] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:30:0) after 1m0s
[12:50:19.676] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:30:0)
[12:50:19.676] Timer tick, asking Buildbucket for the build status
[12:50:19.773] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:19.773] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:31:0) after 1m0s
[12:51:19.774] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:31:0)
[12:51:19.774] Timer tick, asking Buildbucket for the build status
[12:51:19.899] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:19.899] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:32:0) after 1m0s
[12:52:19.917] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:32:0)
[12:52:19.917] Timer tick, asking Buildbucket for the build status
[12:52:20.431] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:20.431] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:33:0) after 1m0s
[12:53:20.608] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:33:0)
[12:53:20.608] Timer tick, asking Buildbucket for the build status
[12:53:20.712] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:20.712] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:34:0) after 1m0s
[12:54:21.033] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:34:0)
[12:54:21.033] Timer tick, asking Buildbucket for the build status
[12:54:21.256] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:21.256] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:35:0) after 1m0s
[12:55:21.307] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:35:0)
[12:55:21.307] Timer tick, asking Buildbucket for the build status
[12:55:21.432] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:21.432] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:36:0) after 1m0s
[12:56:21.551] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:36:0)
[12:56:21.551] Timer tick, asking Buildbucket for the build status
[12:56:21.657] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:21.657] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:37:0) after 1m0s
[12:57:21.711] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:37:0)
[12:57:21.711] Timer tick, asking Buildbucket for the build status
[12:57:21.908] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:21.908] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:38:0) after 1m0s
[12:58:21.936] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:38:0)
[12:58:21.936] Timer tick, asking Buildbucket for the build status
[12:58:22.003] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:22.003] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:39:0) after 1m0s
[12:59:22.064] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:39:0)
[12:59:22.064] Timer tick, asking Buildbucket for the build status
[12:59:22.164] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:22.164] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:40:0) after 1m0s
[13:00:22.237] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:40:0)
[13:00:22.237] Timer tick, asking Buildbucket for the build status
[13:00:22.441] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:22.441] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:41:0) after 1m0s
[13:01:22.535] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:41:0)
[13:01:22.535] Timer tick, asking Buildbucket for the build status
[13:01:22.622] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:22.622] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:42:0) after 1m0s
[13:02:22.748] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:42:0)
[13:02:22.748] Timer tick, asking Buildbucket for the build status
[13:02:22.984] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:22.984] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:43:0) after 1m0s
[13:03:23.020] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:43:0)
[13:03:23.020] Timer tick, asking Buildbucket for the build status
[13:03:23.278] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:23.278] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:44:0) after 1m0s
[13:04:23.358] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:44:0)
[13:04:23.358] Timer tick, asking Buildbucket for the build status
[13:04:23.453] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:23.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:45:0) after 1m0s
[13:05:23.532] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:45:0)
[13:05:23.532] Timer tick, asking Buildbucket for the build status
[13:05:23.679] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:23.679] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:46:0) after 1m0s
[13:06:23.717] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:46:0)
[13:06:23.717] Timer tick, asking Buildbucket for the build status
[13:06:23.838] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:23.838] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:47:0) after 1m0s
[13:07:23.899] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:47:0)
[13:07:23.899] Timer tick, asking Buildbucket for the build status
[13:07:23.990] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:23.990] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:48:0) after 1m0s
[13:08:24.023] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:48:0)
[13:08:24.023] Timer tick, asking Buildbucket for the build status
[13:08:24.629] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:24.629] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:49:0) after 1m0s
[13:09:24.711] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:49:0)
[13:09:24.711] Timer tick, asking Buildbucket for the build status
[13:09:24.827] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:24.827] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:50:0) after 1m0s
[13:10:24.885] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:50:0)
[13:10:24.885] Timer tick, asking Buildbucket for the build status
[13:10:24.964] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:24.964] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:51:0) after 1m0s
[13:11:24.958] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:51:0)
[13:11:24.958] Timer tick, asking Buildbucket for the build status
[13:11:25.067] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:25.067] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:52:0) after 1m0s
[13:12:25.132] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:52:0)
[13:12:25.132] Timer tick, asking Buildbucket for the build status
[13:12:25.294] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:25.295] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:53:0) after 1m0s
[13:13:26.433] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:53:0)
[13:13:26.433] Timer tick, asking Buildbucket for the build status
[13:13:26.681] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:26.681] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:54:0) after 1m0s
[13:14:27.091] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:54:0)
[13:14:27.091] Timer tick, asking Buildbucket for the build status
[13:14:27.345] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:27.345] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:55:0) after 1m0s
[13:15:27.719] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:55:0)
[13:15:27.719] Timer tick, asking Buildbucket for the build status
[13:15:27.825] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:27.825] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:56:0) after 1m0s
[13:16:28.050] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:56:0)
[13:16:28.050] Timer tick, asking Buildbucket for the build status
[13:16:28.219] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:28.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:57:0) after 1m0s
[13:17:28.365] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:57:0)
[13:17:28.365] Timer tick, asking Buildbucket for the build status
[13:17:28.532] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:28.532] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:58:0) after 1m0s
[13:18:28.551] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:58:0)
[13:18:28.551] Timer tick, asking Buildbucket for the build status
[13:18:28.619] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:28.619] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:59:0) after 1m0s
[13:19:28.873] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:59:0)
[13:19:28.873] Timer tick, asking Buildbucket for the build status
[13:19:28.932] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:28.932] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:60:0) after 1m0s
[13:20:29.111] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:60:0)
[13:20:29.111] Timer tick, asking Buildbucket for the build status
[13:20:29.327] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:29.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:61:0) after 1m0s
[13:21:29.474] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:61:0)
[13:21:29.474] Timer tick, asking Buildbucket for the build status
[13:21:29.569] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:29.569] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:62:0) after 1m0s
[13:22:29.656] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:62:0)
[13:22:29.656] Timer tick, asking Buildbucket for the build status
[13:22:29.762] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:29.762] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:63:0) after 1m0s
[13:23:29.861] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:63:0)
[13:23:29.861] Timer tick, asking Buildbucket for the build status
[13:23:29.926] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:29.926] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:64:0) after 1m0s
[13:24:29.934] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:64:0)
[13:24:29.934] Timer tick, asking Buildbucket for the build status
[13:24:30.002] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:30.002] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:65:0) after 1m0s
[13:25:30.084] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:65:0)
[13:25:30.084] Timer tick, asking Buildbucket for the build status
[13:25:31.325] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:31.325] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:66:0) after 1m0s
[13:26:31.497] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:66:0)
[13:26:31.497] Timer tick, asking Buildbucket for the build status
[13:26:32.083] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:32.083] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:67:0) after 1m0s
[13:27:32.305] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:67:0)
[13:27:32.305] Timer tick, asking Buildbucket for the build status
[13:27:32.440] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:32.440] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:68:0) after 1m0s
[13:28:32.537] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:68:0)
[13:28:32.537] Timer tick, asking Buildbucket for the build status
[13:28:33.061] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:33.061] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:69:0) after 1m0s
[13:29:33.086] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:69:0)
[13:29:33.086] Timer tick, asking Buildbucket for the build status
[13:29:33.267] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:33.267] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:70:0) after 1m0s
[13:30:33.458] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:70:0)
[13:30:33.458] Timer tick, asking Buildbucket for the build status
[13:30:33.962] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:33.962] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:71:0) after 1m0s
[13:31:34.039] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:71:0)
[13:31:34.039] Timer tick, asking Buildbucket for the build status
[13:31:34.103] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:34.103] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:72:0) after 1m0s
[13:32:34.146] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:72:0)
[13:32:34.146] Timer tick, asking Buildbucket for the build status
[13:32:34.250] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:34.250] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:73:0) after 1m0s
[13:33:34.273] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:73:0)
[13:33:34.273] Timer tick, asking Buildbucket for the build status
[13:33:35.044] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:35.044] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:74:0) after 1m0s
[13:34:35.110] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:74:0)
[13:34:35.110] Timer tick, asking Buildbucket for the build status
[13:34:35.385] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:35.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:75:0) after 1m0s
[13:35:35.512] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:75:0)
[13:35:35.512] Timer tick, asking Buildbucket for the build status
[13:35:35.592] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:35.592] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:76:0) after 1m0s
[13:36:35.632] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:76:0)
[13:36:35.632] Timer tick, asking Buildbucket for the build status
[13:36:36.013] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:36.013] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:77:0) after 1m0s
[13:37:36.040] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:77:0)
[13:37:36.040] Timer tick, asking Buildbucket for the build status
[13:37:36.502] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:36.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:78:0) after 1m0s
[13:38:36.599] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:78:0)
[13:38:36.599] Timer tick, asking Buildbucket for the build status
[13:38:36.682] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:36.682] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:79:0) after 1m0s
[13:39:36.777] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:79:0)
[13:39:36.777] Timer tick, asking Buildbucket for the build status
[13:39:36.851] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:36.851] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:80:0) after 1m0s
[13:40:36.939] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:80:0)
[13:40:36.939] Timer tick, asking Buildbucket for the build status
[13:40:37.464] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:37.464] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:81:0) after 1m0s
[13:41:37.462] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:81:0)
[13:41:37.462] Timer tick, asking Buildbucket for the build status
[13:41:37.683] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:37.683] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:82:0) after 1m0s
[13:42:37.742] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:82:0)
[13:42:37.742] Timer tick, asking Buildbucket for the build status
[13:42:37.920] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:37.920] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:83:0) after 1m0s
[13:43:38.076] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:83:0)
[13:43:38.076] Timer tick, asking Buildbucket for the build status
[13:43:38.184] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:38.184] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:84:0) after 1m0s
[13:44:38.231] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:84:0)
[13:44:38.231] Timer tick, asking Buildbucket for the build status
[13:44:38.320] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:38.320] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:85:0) after 1m0s
[13:45:38.380] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:85:0)
[13:45:38.380] Timer tick, asking Buildbucket for the build status
[13:45:38.664] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:38.664] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:86:0) after 1m0s
[13:46:38.860] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:86:0)
[13:46:38.860] Timer tick, asking Buildbucket for the build status
[13:46:39.067] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:39.067] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:87:0) after 1m0s
[13:47:39.097] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:87:0)
[13:47:39.097] Timer tick, asking Buildbucket for the build status
[13:47:39.385] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:39.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:88:0) after 1m0s
[13:48:39.441] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:88:0)
[13:48:39.441] Timer tick, asking Buildbucket for the build status
[13:48:39.613] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:39.614] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:89:0) after 1m0s
[13:49:39.664] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:89:0)
[13:49:39.664] Timer tick, asking Buildbucket for the build status
[13:49:39.727] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:39.727] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:90:0) after 1m0s
[13:50:39.780] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:90:0)
[13:50:39.781] Timer tick, asking Buildbucket for the build status
[13:50:39.920] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:39.920] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:91:0) after 1m0s
[13:51:39.978] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:91:0)
[13:51:39.978] Timer tick, asking Buildbucket for the build status
[13:51:40.148] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:40.148] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:92:0) after 1m0s
[13:52:40.179] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:92:0)
[13:52:40.179] Timer tick, asking Buildbucket for the build status
[13:52:40.443] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:40.443] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:93:0) after 1m0s
[13:53:40.486] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:93:0)
[13:53:40.486] Timer tick, asking Buildbucket for the build status
[13:53:41.219] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:41.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:94:0) after 1m0s
[13:54:41.316] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:94:0)
[13:54:41.316] Timer tick, asking Buildbucket for the build status
[13:54:41.477] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:41.477] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:95:0) after 1m0s
[13:55:41.551] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:95:0)
[13:55:41.551] Timer tick, asking Buildbucket for the build status
[13:55:41.705] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:41.705] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:96:0) after 1m0s
[13:56:41.835] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:96:0)
[13:56:41.835] Timer tick, asking Buildbucket for the build status
[13:56:41.922] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:41.922] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:97:0) after 1m0s
[13:57:41.946] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:97:0)
[13:57:41.946] Timer tick, asking Buildbucket for the build status
[13:57:42.210] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:42.210] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:98:0) after 1m0s
[13:58:42.254] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:98:0)
[13:58:42.254] Timer tick, asking Buildbucket for the build status
[13:58:42.312] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:42.312] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:99:0) after 1m0s
[13:59:42.370] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:99:0)
[13:59:42.370] Timer tick, asking Buildbucket for the build status
[13:59:42.566] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:42.566] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:100:0) after 1m0s
[14:00:42.579] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:100:0)
[14:00:42.579] Timer tick, asking Buildbucket for the build status
[14:00:42.818] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:42.818] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:101:0) after 1m0s
[14:01:42.843] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:101:0)
[14:01:42.843] Timer tick, asking Buildbucket for the build status
[14:01:42.906] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:42.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:102:0) after 1m0s
[14:02:43.016] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:102:0)
[14:02:43.016] Timer tick, asking Buildbucket for the build status
[14:02:43.256] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:43.256] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:103:0) after 1m0s
[14:03:43.331] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:103:0)
[14:03:43.331] Timer tick, asking Buildbucket for the build status
[14:03:43.452] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:43.452] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:104:0) after 1m0s
[14:04:43.531] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:104:0)
[14:04:43.531] Timer tick, asking Buildbucket for the build status
[14:04:43.707] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:43.707] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:105:0) after 1m0s
[14:05:43.737] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:105:0)
[14:05:43.737] Timer tick, asking Buildbucket for the build status
[14:05:43.836] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:43.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:106:0) after 1m0s
[14:06:43.872] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:106:0)
[14:06:43.873] Timer tick, asking Buildbucket for the build status
[14:06:43.934] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:43.934] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:107:0) after 1m0s
[14:07:43.959] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:107:0)
[14:07:43.959] Timer tick, asking Buildbucket for the build status
[14:07:44.151] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:44.151] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:108:0) after 1m0s
[14:08:44.178] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:108:0)
[14:08:44.178] Timer tick, asking Buildbucket for the build status
[14:08:44.279] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:44.279] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:109:0) after 1m0s
[14:09:44.303] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:109:0)
[14:09:44.303] Timer tick, asking Buildbucket for the build status
[14:09:44.389] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:44.389] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:110:0) after 1m0s
[14:10:44.499] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:110:0)
[14:10:44.499] Timer tick, asking Buildbucket for the build status
[14:10:44.613] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:44.613] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:111:0) after 1m0s
[14:11:44.702] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:111:0)
[14:11:44.702] Timer tick, asking Buildbucket for the build status
[14:11:44.812] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:44.812] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:112:0) after 1m0s
[14:12:44.864] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:112:0)
[14:12:44.864] Timer tick, asking Buildbucket for the build status
[14:12:44.978] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:44.978] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:113:0) after 1m0s
[14:13:45.011] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:113:0)
[14:13:45.011] Timer tick, asking Buildbucket for the build status
[14:13:45.096] Build 8862205835898730592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:45.096] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027635898555397552:114:0) after 1m0s
[14:14:38.484] Received PubSub notification, asking Buildbucket for the build status
[14:14:38.539] Build 8862205835898730592: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[14:14:38.539] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1606745677654125",
"created_by": "project:r8",
"created_ts": "1606738929805176",
"failure_reason": "BUILD_FAILURE",
"id": "8862205835898730592",
"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\": \"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\", \"title\": \"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\", \"url\": \"https://r8.googlesource.com/r8/+/2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\"}}",
"project": "r8",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('Run tests') (retcode: 1)\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\", \"title\": \"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\", \"url\": \"https://r8.googlesource.com/r8/+/2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\"}]}, \"bot_id\": \"luci-r8-custom-ci-xenial-15-unp5\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-jdk8\", \"buildnumber\": 223, \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"2d3aca6562d2a934d90b7d0390bbf3ecdb245e17\", \"test_options\": [\"--runtimes=jdk8\", \"--no_internal\", \"--one_line_per_test\", \"--archive_failures\"]}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_535ad7637a04c3e27d1496cee679fa117c96e8656eac01642dd379313c9a8210_v2\", \"builder_9add2253e16dc8ad985b1d8f6acea5e24f87773de7e924ed59243ca04d1aea1e_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-15-unp5\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}, \"ui\": {\"info\": \"Step('Run tests') (retcode: 1)\"}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606738971566317",
"status": "COMPLETED",
"status_changed_ts": "1606738972234609",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/223",
"builder:linux-jdk8",
"buildset:commit/git/2d3aca6562d2a934d90b7d0390bbf3ecdb245e17",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/2d3aca6562d2a934d90b7d0390bbf3ecdb245e17",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027635898555397552",
"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/8862205835898730592/+/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:5031ebf72d313e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606745677708344",
"url": "https://ci.chromium.org/b/8862205835898730592",
"utcnow_ts": "1606745678532389"
}
}
[14:14:38.539] Invocation finished in 1h52m30.65059794s with status FAILED