[14:46:06.985] New invocation is queued and will start shortly
[14:46:08.738] Starting the invocation (attempt 1)
[14:46:08.814] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:46:08.814] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:46:08.814] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9027626839847041392",
"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\":\"5173a636054abad72e98821cdc405012fe3deaa2\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@5173a636054abad72e98821cdc405012fe3deaa2\",\"title\":\"5173a636054abad72e98821cdc405012fe3deaa2\",\"url\":\"https://r8.googlesource.com/r8/+/5173a636054abad72e98821cdc405012fe3deaa2\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"5173a636054abad72e98821cdc405012fe3deaa2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-jdk8",
"scheduler_invocation_id:9027626839847041392",
"scheduler_job_id:r8/linux-jdk8",
"user_agent:luci-scheduler",
"buildset:commit/git/5173a636054abad72e98821cdc405012fe3deaa2",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/5173a636054abad72e98821cdc405012fe3deaa2",
"gitiles_ref:refs/heads/master"
]
}
[14:46:10.096] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:r8",
"created_ts": "1606747568962984",
"id": "8862196777086036736",
"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\": \"5173a636054abad72e98821cdc405012fe3deaa2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@5173a636054abad72e98821cdc405012fe3deaa2\", \"title\": \"5173a636054abad72e98821cdc405012fe3deaa2\", \"url\": \"https://r8.googlesource.com/r8/+/5173a636054abad72e98821cdc405012fe3deaa2\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"5173a636054abad72e98821cdc405012fe3deaa2\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606747569893840",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/224",
"builder:linux-jdk8",
"buildset:commit/git/5173a636054abad72e98821cdc405012fe3deaa2",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/5173a636054abad72e98821cdc405012fe3deaa2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027626839847041392",
"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/8862196777086036736/+/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": "1606747569893976",
"url": "https://ci.chromium.org/b/8862196777086036736",
"utcnow_ts": "1606747570066528"
}
}
[14:46:10.096] Task URL: https://ci.chromium.org/b/8862196777086036736
[14:46:10.096] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:2:0) after 1m0s
[14:46:40.154] Received PubSub notification, asking Buildbucket for the build status
[14:46:40.682] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:10.124] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:2:0)
[14:47:10.124] Timer tick, asking Buildbucket for the build status
[14:47:10.804] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:10.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:4:0) after 1m0s
[14:48:10.848] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:4:0)
[14:48:10.848] Timer tick, asking Buildbucket for the build status
[14:48:10.997] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:10.997] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:5:0) after 1m0s
[14:49:11.085] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:5:0)
[14:49:11.085] Timer tick, asking Buildbucket for the build status
[14:49:11.185] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:11.185] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:6:0) after 1m0s
[14:50:11.265] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:6:0)
[14:50:11.265] Timer tick, asking Buildbucket for the build status
[14:50:11.431] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:11.432] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:7:0) after 1m0s
[14:51:11.480] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:7:0)
[14:51:11.480] Timer tick, asking Buildbucket for the build status
[14:51:11.557] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:11.557] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:8:0) after 1m0s
[14:52:11.623] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:8:0)
[14:52:11.623] Timer tick, asking Buildbucket for the build status
[14:52:11.748] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:11.748] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:9:0) after 1m0s
[14:53:11.768] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:9:0)
[14:53:11.768] Timer tick, asking Buildbucket for the build status
[14:53:11.934] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:11.934] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:10:0) after 1m0s
[14:54:12.107] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:10:0)
[14:54:12.107] Timer tick, asking Buildbucket for the build status
[14:54:13.467] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:13.467] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:11:0) after 1m0s
[14:55:13.517] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:11:0)
[14:55:13.517] Timer tick, asking Buildbucket for the build status
[14:55:13.745] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:13.745] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:12:0) after 1m0s
[14:56:13.769] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:12:0)
[14:56:13.769] Timer tick, asking Buildbucket for the build status
[14:56:13.904] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:13.904] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:13:0) after 1m0s
[14:57:13.916] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:13:0)
[14:57:13.916] Timer tick, asking Buildbucket for the build status
[14:57:13.976] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:13.976] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:14:0) after 1m0s
[14:58:14.012] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:14:0)
[14:58:14.013] Timer tick, asking Buildbucket for the build status
[14:58:14.593] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:14.593] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:15:0) after 1m0s
[14:59:14.736] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:15:0)
[14:59:14.736] Timer tick, asking Buildbucket for the build status
[14:59:14.886] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:14.886] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:16:0) after 1m0s
[15:00:15.034] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:16:0)
[15:00:15.034] Timer tick, asking Buildbucket for the build status
[15:00:15.157] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:15.157] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:17:0) after 1m0s
[15:01:15.275] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:17:0)
[15:01:15.275] Timer tick, asking Buildbucket for the build status
[15:01:16.037] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:16.037] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:18:0) after 1m0s
[15:02:16.058] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:18:0)
[15:02:16.058] Timer tick, asking Buildbucket for the build status
[15:02:16.167] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:16.167] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:19:0) after 1m0s
[15:03:16.186] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:19:0)
[15:03:16.187] Timer tick, asking Buildbucket for the build status
[15:03:16.554] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:16.554] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:20:0) after 1m0s
[15:04:16.595] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:20:0)
[15:04:16.595] Timer tick, asking Buildbucket for the build status
[15:04:16.961] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:16.961] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:21:0) after 1m0s
[15:05:17.043] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:21:0)
[15:05:17.043] Timer tick, asking Buildbucket for the build status
[15:05:17.232] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:17.232] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:22:0) after 1m0s
[15:06:17.426] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:22:0)
[15:06:17.427] Timer tick, asking Buildbucket for the build status
[15:06:17.630] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:17.630] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:23:0) after 1m0s
[15:07:17.650] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:23:0)
[15:07:17.650] Timer tick, asking Buildbucket for the build status
[15:07:17.867] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:17.867] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:24:0) after 1m0s
[15:08:17.949] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:24:0)
[15:08:17.949] Timer tick, asking Buildbucket for the build status
[15:08:18.020] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:18.020] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:25:0) after 1m0s
[15:09:18.184] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:25:0)
[15:09:18.184] Timer tick, asking Buildbucket for the build status
[15:09:18.281] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:18.281] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:26:0) after 1m0s
[15:10:18.394] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:26:0)
[15:10:18.394] Timer tick, asking Buildbucket for the build status
[15:10:18.469] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:18.469] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:27:0) after 1m0s
[15:11:18.546] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:27:0)
[15:11:18.546] Timer tick, asking Buildbucket for the build status
[15:11:18.666] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:18.666] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:28:0) after 1m0s
[15:12:18.691] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:28:0)
[15:12:18.691] Timer tick, asking Buildbucket for the build status
[15:12:18.742] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:18.742] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:29:0) after 1m0s
[15:13:18.861] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:29:0)
[15:13:18.861] Timer tick, asking Buildbucket for the build status
[15:13:18.933] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:18.933] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:30:0) after 1m0s
[15:14:18.990] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:30:0)
[15:14:18.990] Timer tick, asking Buildbucket for the build status
[15:14:19.054] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:19.054] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:31:0) after 1m0s
[15:15:19.415] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:31:0)
[15:15:19.415] Timer tick, asking Buildbucket for the build status
[15:15:19.474] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:19.474] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:32:0) after 1m0s
[15:16:19.550] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:32:0)
[15:16:19.550] Timer tick, asking Buildbucket for the build status
[15:16:19.990] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:19.990] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:33:0) after 1m0s
[15:17:20.196] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:33:0)
[15:17:20.196] Timer tick, asking Buildbucket for the build status
[15:17:20.302] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:20.302] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:34:0) after 1m0s
[15:18:20.374] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:34:0)
[15:18:20.374] Timer tick, asking Buildbucket for the build status
[15:18:20.941] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:20.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:35:0) after 1m0s
[15:19:20.961] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:35:0)
[15:19:20.961] Timer tick, asking Buildbucket for the build status
[15:19:21.053] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:21.053] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:36:0) after 1m0s
[15:20:21.116] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:36:0)
[15:20:21.116] Timer tick, asking Buildbucket for the build status
[15:20:21.190] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:21.190] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:37:0) after 1m0s
[15:21:21.286] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:37:0)
[15:21:21.286] Timer tick, asking Buildbucket for the build status
[15:21:21.451] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:21.451] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:38:0) after 1m0s
[15:22:21.468] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:38:0)
[15:22:21.468] Timer tick, asking Buildbucket for the build status
[15:22:21.538] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:21.538] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:39:0) after 1m0s
[15:23:21.572] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:39:0)
[15:23:21.572] Timer tick, asking Buildbucket for the build status
[15:23:21.686] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:21.686] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:40:0) after 1m0s
[15:24:21.738] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:40:0)
[15:24:21.738] Timer tick, asking Buildbucket for the build status
[15:24:21.805] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:21.805] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:41:0) after 1m0s
[15:25:21.839] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:41:0)
[15:25:21.839] Timer tick, asking Buildbucket for the build status
[15:25:22.754] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:22.754] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:42:0) after 1m0s
[15:26:22.838] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:42:0)
[15:26:22.838] Timer tick, asking Buildbucket for the build status
[15:26:22.974] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:22.974] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:43:0) after 1m0s
[15:27:22.991] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:43:0)
[15:27:22.991] Timer tick, asking Buildbucket for the build status
[15:27:23.709] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:23.709] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:44:0) after 1m0s
[15:28:23.735] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:44:0)
[15:28:23.735] Timer tick, asking Buildbucket for the build status
[15:28:24.335] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:24.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:45:0) after 1m0s
[15:29:24.403] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:45:0)
[15:29:24.403] Timer tick, asking Buildbucket for the build status
[15:29:24.541] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:24.541] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:46:0) after 1m0s
[15:30:24.781] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:46:0)
[15:30:24.781] Timer tick, asking Buildbucket for the build status
[15:30:26.033] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:26.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:47:0) after 1m0s
[15:31:26.170] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:47:0)
[15:31:26.170] Timer tick, asking Buildbucket for the build status
[15:31:28.165] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:28.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:48:0) after 1m0s
[15:32:28.224] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:48:0)
[15:32:28.224] Timer tick, asking Buildbucket for the build status
[15:32:28.307] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:28.307] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:49:0) after 1m0s
[15:33:28.413] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:49:0)
[15:33:28.413] Timer tick, asking Buildbucket for the build status
[15:33:28.499] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:28.499] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:50:0) after 1m0s
[15:34:28.549] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:50:0)
[15:34:28.549] Timer tick, asking Buildbucket for the build status
[15:34:28.667] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:28.667] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:51:0) after 1m0s
[15:35:28.717] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:51:0)
[15:35:28.717] Timer tick, asking Buildbucket for the build status
[15:35:28.937] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:28.937] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:52:0) after 1m0s
[15:36:29.030] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:52:0)
[15:36:29.030] Timer tick, asking Buildbucket for the build status
[15:36:29.726] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:29.726] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:53:0) after 1m0s
[15:37:29.794] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:53:0)
[15:37:29.794] Timer tick, asking Buildbucket for the build status
[15:37:30.121] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:30.121] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:54:0) after 1m0s
[15:38:30.215] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:54:0)
[15:38:30.215] Timer tick, asking Buildbucket for the build status
[15:38:30.573] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:30.573] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:55:0) after 1m0s
[15:39:30.740] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:55:0)
[15:39:30.740] Timer tick, asking Buildbucket for the build status
[15:39:32.284] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:32.284] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:56:0) after 1m0s
[15:40:32.347] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:56:0)
[15:40:32.347] Timer tick, asking Buildbucket for the build status
[15:40:32.408] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:32.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:57:0) after 1m0s
[15:41:32.507] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:57:0)
[15:41:32.507] Timer tick, asking Buildbucket for the build status
[15:41:32.839] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:32.839] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:58:0) after 1m0s
[15:42:32.845] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:58:0)
[15:42:32.845] Timer tick, asking Buildbucket for the build status
[15:42:33.293] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:33.293] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:59:0) after 1m0s
[15:43:33.322] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:59:0)
[15:43:33.322] Timer tick, asking Buildbucket for the build status
[15:43:33.570] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:33.570] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:60:0) after 1m0s
[15:44:33.644] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:60:0)
[15:44:33.644] Timer tick, asking Buildbucket for the build status
[15:44:34.945] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:34.945] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:61:0) after 1m0s
[15:45:34.986] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:61:0)
[15:45:34.986] Timer tick, asking Buildbucket for the build status
[15:45:35.083] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:35.083] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:62:0) after 1m0s
[15:46:35.563] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:62:0)
[15:46:35.563] Timer tick, asking Buildbucket for the build status
[15:46:35.765] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:35.765] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:63:0) after 1m0s
[15:47:38.723] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:63:0)
[15:47:38.723] Timer tick, asking Buildbucket for the build status
[15:47:38.838] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:38.838] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:64:0) after 1m0s
[15:48:39.329] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:64:0)
[15:48:39.329] Timer tick, asking Buildbucket for the build status
[15:48:39.436] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:39.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:65:0) after 1m0s
[15:49:39.657] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:65:0)
[15:49:39.657] Timer tick, asking Buildbucket for the build status
[15:49:39.717] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:39.717] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:66:0) after 1m0s
[15:50:40.079] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:66:0)
[15:50:40.079] Timer tick, asking Buildbucket for the build status
[15:50:40.603] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:40.603] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:67:0) after 1m0s
[15:51:41.067] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:67:0)
[15:51:41.067] Timer tick, asking Buildbucket for the build status
[15:51:41.156] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:41.156] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:68:0) after 1m0s
[15:52:41.635] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:68:0)
[15:52:41.635] Timer tick, asking Buildbucket for the build status
[15:52:41.770] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:41.770] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:69:0) after 1m0s
[15:53:41.829] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:69:0)
[15:53:41.829] Timer tick, asking Buildbucket for the build status
[15:53:42.896] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:42.896] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:70:0) after 1m0s
[15:54:43.637] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:70:0)
[15:54:43.637] Timer tick, asking Buildbucket for the build status
[15:54:43.724] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:43.724] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:71:0) after 1m0s
[15:55:43.878] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:71:0)
[15:55:43.878] Timer tick, asking Buildbucket for the build status
[15:55:43.962] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:43.962] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:72:0) after 1m0s
[15:56:43.981] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:72:0)
[15:56:43.981] Timer tick, asking Buildbucket for the build status
[15:56:46.090] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:46.091] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:73:0) after 1m0s
[15:57:46.202] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:73:0)
[15:57:46.202] Timer tick, asking Buildbucket for the build status
[15:57:46.646] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:46.646] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:74:0) after 1m0s
[15:58:46.844] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:74:0)
[15:58:46.844] Timer tick, asking Buildbucket for the build status
[15:58:47.436] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:47.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:75:0) after 1m0s
[15:59:47.788] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:75:0)
[15:59:47.788] Timer tick, asking Buildbucket for the build status
[15:59:48.005] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:48.005] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:76:0) after 1m0s
[16:00:48.105] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:76:0)
[16:00:48.105] Timer tick, asking Buildbucket for the build status
[16:00:50.804] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:50.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:77:0) after 1m0s
[16:01:50.832] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:77:0)
[16:01:50.832] Timer tick, asking Buildbucket for the build status
[16:01:51.166] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:51.166] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:78:0) after 1m0s
[16:02:51.289] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:78:0)
[16:02:51.289] Timer tick, asking Buildbucket for the build status
[16:02:51.356] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:51.356] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:79:0) after 1m0s
[16:03:51.478] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:79:0)
[16:03:51.478] Timer tick, asking Buildbucket for the build status
[16:03:51.550] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:51.550] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:80:0) after 1m0s
[16:04:52.131] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:80:0)
[16:04:52.131] Timer tick, asking Buildbucket for the build status
[16:04:52.309] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:52.310] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:81:0) after 1m0s
[16:05:52.398] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:81:0)
[16:05:52.398] Timer tick, asking Buildbucket for the build status
[16:05:52.755] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:52.755] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:82:0) after 1m0s
[16:06:52.880] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:82:0)
[16:06:52.880] Timer tick, asking Buildbucket for the build status
[16:06:56.383] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:56.383] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:83:0) after 1m0s
[16:07:56.425] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:83:0)
[16:07:56.425] Timer tick, asking Buildbucket for the build status
[16:07:56.491] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:56.491] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:84:0) after 1m0s
[16:08:56.538] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:84:0)
[16:08:56.538] Timer tick, asking Buildbucket for the build status
[16:08:59.231] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:59.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:85:0) after 1m0s
[16:09:59.317] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:85:0)
[16:09:59.317] Timer tick, asking Buildbucket for the build status
[16:09:59.384] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:59.384] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:86:0) after 1m0s
[16:10:59.456] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:86:0)
[16:10:59.456] Timer tick, asking Buildbucket for the build status
[16:10:59.580] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:59.580] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:87:0) after 1m0s
[16:11:59.635] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:87:0)
[16:11:59.635] Timer tick, asking Buildbucket for the build status
[16:11:59.949] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:59.949] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:88:0) after 1m0s
[16:12:59.950] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:88:0)
[16:12:59.950] Timer tick, asking Buildbucket for the build status
[16:13:00.197] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:00.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:89:0) after 1m0s
[16:14:00.235] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:89:0)
[16:14:00.235] Timer tick, asking Buildbucket for the build status
[16:14:00.347] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:00.347] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:90:0) after 1m0s
[16:15:00.596] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:90:0)
[16:15:00.596] Timer tick, asking Buildbucket for the build status
[16:15:00.718] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:00.718] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:91:0) after 1m0s
[16:16:00.931] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:91:0)
[16:16:00.931] Timer tick, asking Buildbucket for the build status
[16:16:01.087] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:01.087] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:92:0) after 1m0s
[16:17:01.173] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:92:0)
[16:17:01.173] Timer tick, asking Buildbucket for the build status
[16:17:01.529] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:01.529] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:93:0) after 1m0s
[16:18:01.559] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:93:0)
[16:18:01.559] Timer tick, asking Buildbucket for the build status
[16:18:01.652] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:01.652] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:94:0) after 1m0s
[16:19:01.719] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:94:0)
[16:19:01.719] Timer tick, asking Buildbucket for the build status
[16:19:01.971] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:01.971] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:95:0) after 1m0s
[16:20:02.833] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:95:0)
[16:20:02.833] Timer tick, asking Buildbucket for the build status
[16:20:02.973] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:02.973] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:96:0) after 1m0s
[16:21:03.030] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:96:0)
[16:21:03.030] Timer tick, asking Buildbucket for the build status
[16:21:03.138] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:03.138] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:97:0) after 1m0s
[16:22:03.198] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:97:0)
[16:22:03.198] Timer tick, asking Buildbucket for the build status
[16:22:03.922] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:03.922] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:98:0) after 1m0s
[16:23:03.978] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:98:0)
[16:23:03.978] Timer tick, asking Buildbucket for the build status
[16:23:04.255] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:04.255] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:99:0) after 1m0s
[16:24:04.441] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:99:0)
[16:24:04.442] Timer tick, asking Buildbucket for the build status
[16:24:04.639] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:04.639] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:100:0) after 1m0s
[16:25:04.688] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:100:0)
[16:25:04.688] Timer tick, asking Buildbucket for the build status
[16:25:04.972] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:04.973] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:101:0) after 1m0s
[16:26:05.077] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:101:0)
[16:26:05.077] Timer tick, asking Buildbucket for the build status
[16:26:05.492] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:05.492] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:102:0) after 1m0s
[16:27:05.538] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:102:0)
[16:27:05.538] Timer tick, asking Buildbucket for the build status
[16:27:05.735] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:05.735] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:103:0) after 1m0s
[16:28:05.911] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:103:0)
[16:28:05.911] Timer tick, asking Buildbucket for the build status
[16:28:06.003] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:06.003] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:104:0) after 1m0s
[16:29:06.037] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:104:0)
[16:29:06.037] Timer tick, asking Buildbucket for the build status
[16:29:06.146] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:06.146] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:105:0) after 1m0s
[16:30:06.187] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:105:0)
[16:30:06.187] Timer tick, asking Buildbucket for the build status
[16:30:06.260] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:06.260] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:106:0) after 1m0s
[16:31:06.340] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:106:0)
[16:31:06.340] Timer tick, asking Buildbucket for the build status
[16:31:06.616] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:06.616] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:107:0) after 1m0s
[16:32:06.713] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:107:0)
[16:32:06.713] Timer tick, asking Buildbucket for the build status
[16:32:06.903] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:06.903] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:108:0) after 1m0s
[16:33:07.052] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:108:0)
[16:33:07.052] Timer tick, asking Buildbucket for the build status
[16:33:07.357] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:07.357] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:109:0) after 1m0s
[16:34:07.450] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:109:0)
[16:34:07.450] Timer tick, asking Buildbucket for the build status
[16:34:07.545] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:07.545] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:110:0) after 1m0s
[16:35:07.654] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:110:0)
[16:35:07.654] Timer tick, asking Buildbucket for the build status
[16:35:08.033] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:08.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:111:0) after 1m0s
[16:36:08.122] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:111:0)
[16:36:08.122] Timer tick, asking Buildbucket for the build status
[16:36:10.782] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:10.782] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:112:0) after 1m0s
[16:37:10.840] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:112:0)
[16:37:10.840] Timer tick, asking Buildbucket for the build status
[16:37:11.426] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:11.426] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:113:0) after 1m0s
[16:38:11.962] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:113:0)
[16:38:11.962] Timer tick, asking Buildbucket for the build status
[16:38:12.112] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:12.112] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:114:0) after 1m0s
[16:39:12.349] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:114:0)
[16:39:12.349] Timer tick, asking Buildbucket for the build status
[16:39:12.978] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:12.978] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:115:0) after 1m0s
[16:40:13.174] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:115:0)
[16:40:13.174] Timer tick, asking Buildbucket for the build status
[16:40:13.349] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:13.349] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:116:0) after 1m0s
[16:41:13.695] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:116:0)
[16:41:13.695] Timer tick, asking Buildbucket for the build status
[16:41:13.830] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:13.831] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:117:0) after 1m0s
[16:42:13.880] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:117:0)
[16:42:13.880] Timer tick, asking Buildbucket for the build status
[16:42:14.393] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:14.393] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:118:0) after 1m0s
[16:43:14.515] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:118:0)
[16:43:14.515] Timer tick, asking Buildbucket for the build status
[16:43:14.786] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:14.786] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:119:0) after 1m0s
[16:44:14.804] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:119:0)
[16:44:14.804] Timer tick, asking Buildbucket for the build status
[16:44:16.369] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:16.370] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:120:0) after 1m0s
[16:45:16.501] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:120:0)
[16:45:16.501] Timer tick, asking Buildbucket for the build status
[16:45:16.798] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:16.798] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:121:0) after 1m0s
[16:46:16.835] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:121:0)
[16:46:16.835] Timer tick, asking Buildbucket for the build status
[16:46:16.970] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:16.970] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:122:0) after 1m0s
[16:47:17.002] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:122:0)
[16:47:17.002] Timer tick, asking Buildbucket for the build status
[16:47:17.917] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:17.917] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:123:0) after 1m0s
[16:48:18.053] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:123:0)
[16:48:18.053] Timer tick, asking Buildbucket for the build status
[16:48:18.453] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:18.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:124:0) after 1m0s
[16:49:18.642] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:124:0)
[16:49:18.642] Timer tick, asking Buildbucket for the build status
[16:49:18.775] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:18.775] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:125:0) after 1m0s
[16:50:18.847] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:125:0)
[16:50:18.847] Timer tick, asking Buildbucket for the build status
[16:50:20.400] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:20.400] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:126:0) after 1m0s
[16:51:20.572] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:126:0)
[16:51:20.572] Timer tick, asking Buildbucket for the build status
[16:51:20.642] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:20.642] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:127:0) after 1m0s
[16:52:20.758] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:127:0)
[16:52:20.758] Timer tick, asking Buildbucket for the build status
[16:52:20.873] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:20.873] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:128:0) after 1m0s
[16:53:21.101] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:128:0)
[16:53:21.101] Timer tick, asking Buildbucket for the build status
[16:53:21.230] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:21.230] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:129:0) after 1m0s
[16:54:21.299] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:129:0)
[16:54:21.299] Timer tick, asking Buildbucket for the build status
[16:54:21.739] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:21.739] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:130:0) after 1m0s
[16:55:21.823] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:130:0)
[16:55:21.823] Timer tick, asking Buildbucket for the build status
[16:55:22.142] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:22.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:131:0) after 1m0s
[16:56:22.208] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:131:0)
[16:56:22.208] Timer tick, asking Buildbucket for the build status
[16:56:22.442] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:22.442] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:132:0) after 1m0s
[16:57:22.581] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:132:0)
[16:57:22.581] Timer tick, asking Buildbucket for the build status
[16:57:23.404] Build 8862196777086036736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:23.404] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9027626839847041392:133:0) after 1m0s
[16:57:45.023] Received PubSub notification, asking Buildbucket for the build status
[16:57:45.579] Build 8862196777086036736: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:57:45.579] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1606755464282048",
"created_by": "project:r8",
"created_ts": "1606747568962984",
"id": "8862196777086036736",
"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\": \"5173a636054abad72e98821cdc405012fe3deaa2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@5173a636054abad72e98821cdc405012fe3deaa2\", \"title\": \"5173a636054abad72e98821cdc405012fe3deaa2\", \"url\": \"https://r8.googlesource.com/r8/+/5173a636054abad72e98821cdc405012fe3deaa2\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"5173a636054abad72e98821cdc405012fe3deaa2\"}}",
"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\": \"5173a636054abad72e98821cdc405012fe3deaa2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@5173a636054abad72e98821cdc405012fe3deaa2\", \"title\": \"5173a636054abad72e98821cdc405012fe3deaa2\", \"url\": \"https://r8.googlesource.com/r8/+/5173a636054abad72e98821cdc405012fe3deaa2\"}]}, \"bot_id\": \"luci-r8-custom-ci-xenial-2-0yfy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-jdk8\", \"buildnumber\": 224, \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"5173a636054abad72e98821cdc405012fe3deaa2\", \"test_options\": [\"--runtimes=jdk8\", \"--no_internal\", \"--one_line_per_test\", \"--archive_failures\"]}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_535ad7637a04c3e27d1496cee679fa117c96e8656eac01642dd379313c9a8210_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"r8bot-265908\"], \"gpu\": [\"none\"], \"id\": [\"luci-r8-custom-ci-xenial-2-0yfy\"], \"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\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606747599095491",
"status": "COMPLETED",
"status_changed_ts": "1606755464749085",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/224",
"builder:linux-jdk8",
"buildset:commit/git/5173a636054abad72e98821cdc405012fe3deaa2",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/5173a636054abad72e98821cdc405012fe3deaa2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027626839847041392",
"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/8862196777086036736/+/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:50326fcba0c27c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606755464778326",
"url": "https://ci.chromium.org/b/8862196777086036736",
"utcnow_ts": "1606755465558633"
}
}
[16:57:45.579] Invocation finished in 2h11m38.633409436s with status SUCCEEDED