[14:00:18.214] New invocation is queued and will start shortly
[14:00:19.365] Starting the invocation (attempt 1)
[14:00:19.415] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:00:19.416] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:00:19.416] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9022193904141687632",
"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\":\"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\",\"title\":\"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\",\"url\":\"https://r8.googlesource.com/r8/+/01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-jdk8",
"scheduler_invocation_id:9022193904141687632",
"scheduler_job_id:r8/linux-jdk8",
"user_agent:luci-scheduler",
"buildset:commit/git/01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc",
"gitiles_ref:refs/heads/master"
]
}
[14:00:20.145] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1611928819554622",
"id": "8856763842065471584",
"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\": \"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\", \"title\": \"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\", \"url\": \"https://r8.googlesource.com/r8/+/01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611928819959276",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/423",
"builder:linux-jdk8",
"buildset:commit/git/01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022193904141687632",
"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/8856763842065471584/+/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": "1611928819959381",
"url": "https://ci.chromium.org/b/8856763842065471584",
"utcnow_ts": "1611928820133767"
}
}
[14:00:20.145] Task URL: https://ci.chromium.org/b/8856763842065471584
[14:00:20.145] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:2:0) after 1m0s
[14:01:20.276] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:2:0)
[14:01:20.276] Timer tick, asking Buildbucket for the build status
[14:01:20.494] Build 8856763842065471584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:01:20.494] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:3:0) after 1m0s
[14:02:20.599] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:3:0)
[14:02:20.599] Timer tick, asking Buildbucket for the build status
[14:02:20.677] Build 8856763842065471584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:02:20.677] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:4:0) after 1m0s
[14:03:20.708] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:4:0)
[14:03:20.708] Timer tick, asking Buildbucket for the build status
[14:03:20.849] Build 8856763842065471584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:03:20.849] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:5:0) after 1m0s
[14:04:20.839] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:5:0)
[14:04:20.839] Timer tick, asking Buildbucket for the build status
[14:04:20.907] Build 8856763842065471584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:04:20.907] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:6:0) after 1m0s
[14:05:20.989] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:6:0)
[14:05:20.989] Timer tick, asking Buildbucket for the build status
[14:05:21.092] Build 8856763842065471584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:05:21.092] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:7:0) after 1m0s
[14:06:21.115] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:7:0)
[14:06:21.115] Timer tick, asking Buildbucket for the build status
[14:06:21.512] Build 8856763842065471584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:06:21.512] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:8:0) after 1m0s
[14:07:21.563] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:8:0)
[14:07:21.563] Timer tick, asking Buildbucket for the build status
[14:07:21.637] Build 8856763842065471584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:07:21.637] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:9:0) after 1m0s
[14:08:11.253] Received PubSub notification, asking Buildbucket for the build status
[14:08:11.349] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:21.653] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:9:0)
[14:08:21.653] Timer tick, asking Buildbucket for the build status
[14:08:21.850] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:21.850] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:11:0) after 1m0s
[14:09:21.856] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:11:0)
[14:09:21.856] Timer tick, asking Buildbucket for the build status
[14:09:21.973] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:21.973] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:12:0) after 1m0s
[14:10:22.011] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:12:0)
[14:10:22.011] Timer tick, asking Buildbucket for the build status
[14:10:22.096] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:22.096] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:13:0) after 1m0s
[14:11:22.118] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:13:0)
[14:11:22.118] Timer tick, asking Buildbucket for the build status
[14:11:22.175] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:22.175] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:14:0) after 1m0s
[14:12:22.201] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:14:0)
[14:12:22.201] Timer tick, asking Buildbucket for the build status
[14:12:22.435] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:22.435] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:15:0) after 1m0s
[14:13:22.413] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:15:0)
[14:13:22.413] Timer tick, asking Buildbucket for the build status
[14:13:22.855] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:22.855] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:16:0) after 1m0s
[14:14:22.891] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:16:0)
[14:14:22.891] Timer tick, asking Buildbucket for the build status
[14:14:22.961] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:22.961] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:17:0) after 1m0s
[14:15:23.024] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:17:0)
[14:15:23.024] Timer tick, asking Buildbucket for the build status
[14:15:23.284] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:23.284] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:18:0) after 1m0s
[14:16:23.313] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:18:0)
[14:16:23.313] Timer tick, asking Buildbucket for the build status
[14:16:23.383] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:23.383] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:19:0) after 1m0s
[14:17:23.405] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:19:0)
[14:17:23.405] Timer tick, asking Buildbucket for the build status
[14:17:23.635] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:23.635] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:20:0) after 1m0s
[14:18:23.660] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:20:0)
[14:18:23.660] Timer tick, asking Buildbucket for the build status
[14:18:23.843] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:23.843] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:21:0) after 1m0s
[14:19:23.867] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:21:0)
[14:19:23.867] Timer tick, asking Buildbucket for the build status
[14:19:23.942] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:23.942] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:22:0) after 1m0s
[14:20:23.964] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:22:0)
[14:20:23.964] Timer tick, asking Buildbucket for the build status
[14:20:24.050] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:24.050] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:23:0) after 1m0s
[14:21:24.072] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:23:0)
[14:21:24.072] Timer tick, asking Buildbucket for the build status
[14:21:24.197] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:24.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:24:0) after 1m0s
[14:22:24.244] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:24:0)
[14:22:24.244] Timer tick, asking Buildbucket for the build status
[14:22:24.311] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:24.311] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:25:0) after 1m0s
[14:23:24.316] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:25:0)
[14:23:24.316] Timer tick, asking Buildbucket for the build status
[14:23:24.374] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:24.374] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:26:0) after 1m0s
[14:24:24.406] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:26:0)
[14:24:24.406] Timer tick, asking Buildbucket for the build status
[14:24:24.523] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:24.523] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:27:0) after 1m0s
[14:25:24.540] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:27:0)
[14:25:24.540] Timer tick, asking Buildbucket for the build status
[14:25:24.685] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:24.685] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:28:0) after 1m0s
[14:26:24.709] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:28:0)
[14:26:24.709] Timer tick, asking Buildbucket for the build status
[14:26:25.124] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:25.124] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:29:0) after 1m0s
[14:27:25.145] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:29:0)
[14:27:25.145] Timer tick, asking Buildbucket for the build status
[14:27:25.232] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:25.232] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:30:0) after 1m0s
[14:28:25.317] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:30:0)
[14:28:25.317] Timer tick, asking Buildbucket for the build status
[14:28:25.381] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:25.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:31:0) after 1m0s
[14:29:25.512] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:31:0)
[14:29:25.512] Timer tick, asking Buildbucket for the build status
[14:29:25.575] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:25.575] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:32:0) after 1m0s
[14:30:25.794] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:32:0)
[14:30:25.794] Timer tick, asking Buildbucket for the build status
[14:30:26.327] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:26.328] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:33:0) after 1m0s
[14:31:26.342] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:33:0)
[14:31:26.342] Timer tick, asking Buildbucket for the build status
[14:31:26.415] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:26.415] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:34:0) after 1m0s
[14:32:26.517] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:34:0)
[14:32:26.517] Timer tick, asking Buildbucket for the build status
[14:32:26.807] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:26.807] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:35:0) after 1m0s
[14:33:26.905] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:35:0)
[14:33:26.905] Timer tick, asking Buildbucket for the build status
[14:33:26.965] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:26.965] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:36:0) after 1m0s
[14:34:26.999] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:36:0)
[14:34:26.999] Timer tick, asking Buildbucket for the build status
[14:34:27.064] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:27.064] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:37:0) after 1m0s
[14:35:27.078] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:37:0)
[14:35:27.078] Timer tick, asking Buildbucket for the build status
[14:35:27.280] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:27.280] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:38:0) after 1m0s
[14:36:27.395] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:38:0)
[14:36:27.395] Timer tick, asking Buildbucket for the build status
[14:36:27.465] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:27.465] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:39:0) after 1m0s
[14:37:27.617] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:39:0)
[14:37:27.617] Timer tick, asking Buildbucket for the build status
[14:37:27.711] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:27.711] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:40:0) after 1m0s
[14:38:27.801] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:40:0)
[14:38:27.801] Timer tick, asking Buildbucket for the build status
[14:38:28.133] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:28.133] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:41:0) after 1m0s
[14:39:28.283] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:41:0)
[14:39:28.283] Timer tick, asking Buildbucket for the build status
[14:39:28.398] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:28.398] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:42:0) after 1m0s
[14:40:28.419] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:42:0)
[14:40:28.419] Timer tick, asking Buildbucket for the build status
[14:40:28.560] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:28.561] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:43:0) after 1m0s
[14:41:28.625] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:43:0)
[14:41:28.625] Timer tick, asking Buildbucket for the build status
[14:41:28.720] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:28.720] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:44:0) after 1m0s
[14:42:28.771] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:44:0)
[14:42:28.771] Timer tick, asking Buildbucket for the build status
[14:42:29.038] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:29.038] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:45:0) after 1m0s
[14:43:29.091] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:45:0)
[14:43:29.091] Timer tick, asking Buildbucket for the build status
[14:43:29.168] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:29.168] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:46:0) after 1m0s
[14:44:29.242] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:46:0)
[14:44:29.242] Timer tick, asking Buildbucket for the build status
[14:44:29.445] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:29.445] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:47:0) after 1m0s
[14:45:29.524] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:47:0)
[14:45:29.524] Timer tick, asking Buildbucket for the build status
[14:45:29.716] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:29.716] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:48:0) after 1m0s
[14:46:29.779] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:48:0)
[14:46:29.779] Timer tick, asking Buildbucket for the build status
[14:46:29.846] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:29.847] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:49:0) after 1m0s
[14:47:29.913] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:49:0)
[14:47:29.913] Timer tick, asking Buildbucket for the build status
[14:47:30.007] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:30.007] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:50:0) after 1m0s
[14:48:30.066] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:50:0)
[14:48:30.066] Timer tick, asking Buildbucket for the build status
[14:48:30.126] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:30.126] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:51:0) after 1m0s
[14:49:30.247] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:51:0)
[14:49:30.247] Timer tick, asking Buildbucket for the build status
[14:49:30.324] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:30.324] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:52:0) after 1m0s
[14:50:30.314] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:52:0)
[14:50:30.314] Timer tick, asking Buildbucket for the build status
[14:50:30.471] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:30.471] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:53:0) after 1m0s
[14:51:30.499] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:53:0)
[14:51:30.499] Timer tick, asking Buildbucket for the build status
[14:51:30.585] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:30.585] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:54:0) after 1m0s
[14:52:30.610] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:54:0)
[14:52:30.610] Timer tick, asking Buildbucket for the build status
[14:52:30.667] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:30.667] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:55:0) after 1m0s
[14:53:30.732] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:55:0)
[14:53:30.732] Timer tick, asking Buildbucket for the build status
[14:53:30.806] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:30.806] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:56:0) after 1m0s
[14:54:30.892] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:56:0)
[14:54:30.892] Timer tick, asking Buildbucket for the build status
[14:54:30.964] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:30.964] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:57:0) after 1m0s
[14:55:31.062] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:57:0)
[14:55:31.062] Timer tick, asking Buildbucket for the build status
[14:55:31.587] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:31.587] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:58:0) after 1m0s
[14:56:31.650] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:58:0)
[14:56:31.650] Timer tick, asking Buildbucket for the build status
[14:56:31.725] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:31.725] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:59:0) after 1m0s
[14:57:31.869] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:59:0)
[14:57:31.869] Timer tick, asking Buildbucket for the build status
[14:57:31.941] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:31.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:60:0) after 1m0s
[14:58:32.637] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:60:0)
[14:58:32.637] Timer tick, asking Buildbucket for the build status
[14:58:32.714] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:32.714] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:61:0) after 1m0s
[14:59:32.938] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:61:0)
[14:59:32.938] Timer tick, asking Buildbucket for the build status
[14:59:33.025] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:33.025] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:62:0) after 1m0s
[15:00:33.202] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:62:0)
[15:00:33.202] Timer tick, asking Buildbucket for the build status
[15:00:33.313] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:33.313] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:63:0) after 1m0s
[15:01:33.383] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:63:0)
[15:01:33.383] Timer tick, asking Buildbucket for the build status
[15:01:33.447] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:33.447] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:64:0) after 1m0s
[15:02:33.526] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:64:0)
[15:02:33.526] Timer tick, asking Buildbucket for the build status
[15:02:33.818] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:33.818] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:65:0) after 1m0s
[15:03:34.105] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:65:0)
[15:03:34.105] Timer tick, asking Buildbucket for the build status
[15:03:34.239] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:34.239] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:66:0) after 1m0s
[15:04:34.417] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:66:0)
[15:04:34.417] Timer tick, asking Buildbucket for the build status
[15:04:34.619] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:34.619] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:67:0) after 1m0s
[15:05:34.690] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:67:0)
[15:05:34.690] Timer tick, asking Buildbucket for the build status
[15:05:34.885] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:34.885] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:68:0) after 1m0s
[15:06:34.967] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:68:0)
[15:06:34.967] Timer tick, asking Buildbucket for the build status
[15:06:35.157] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:35.157] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:69:0) after 1m0s
[15:07:35.315] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:69:0)
[15:07:35.315] Timer tick, asking Buildbucket for the build status
[15:07:35.380] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:35.380] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:70:0) after 1m0s
[15:08:35.529] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:70:0)
[15:08:35.529] Timer tick, asking Buildbucket for the build status
[15:08:35.599] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:35.599] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:71:0) after 1m0s
[15:09:35.596] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:71:0)
[15:09:35.596] Timer tick, asking Buildbucket for the build status
[15:09:35.726] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:35.726] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:72:0) after 1m0s
[15:10:35.884] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:72:0)
[15:10:35.884] Timer tick, asking Buildbucket for the build status
[15:10:36.340] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:36.341] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:73:0) after 1m0s
[15:11:36.383] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:73:0)
[15:11:36.383] Timer tick, asking Buildbucket for the build status
[15:11:36.458] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:36.458] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:74:0) after 1m0s
[15:12:36.664] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:74:0)
[15:12:36.664] Timer tick, asking Buildbucket for the build status
[15:12:36.740] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:36.740] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:75:0) after 1m0s
[15:13:36.757] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:75:0)
[15:13:36.757] Timer tick, asking Buildbucket for the build status
[15:13:36.817] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:36.817] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:76:0) after 1m0s
[15:14:36.910] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:76:0)
[15:14:36.911] Timer tick, asking Buildbucket for the build status
[15:14:36.982] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:36.982] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:77:0) after 1m0s
[15:15:37.042] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:77:0)
[15:15:37.042] Timer tick, asking Buildbucket for the build status
[15:15:37.146] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:37.146] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:78:0) after 1m0s
[15:16:37.433] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:78:0)
[15:16:37.433] Timer tick, asking Buildbucket for the build status
[15:16:37.491] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:37.491] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:79:0) after 1m0s
[15:17:37.587] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:79:0)
[15:17:37.587] Timer tick, asking Buildbucket for the build status
[15:17:37.661] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:37.661] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:80:0) after 1m0s
[15:18:37.928] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:80:0)
[15:18:37.928] Timer tick, asking Buildbucket for the build status
[15:18:38.055] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:38.055] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:81:0) after 1m0s
[15:19:38.180] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:81:0)
[15:19:38.180] Timer tick, asking Buildbucket for the build status
[15:19:38.900] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:38.900] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:82:0) after 1m0s
[15:20:39.096] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:82:0)
[15:20:39.096] Timer tick, asking Buildbucket for the build status
[15:20:39.218] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:39.218] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:83:0) after 1m0s
[15:21:39.444] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:83:0)
[15:21:39.444] Timer tick, asking Buildbucket for the build status
[15:21:39.535] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:39.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:84:0) after 1m0s
[15:22:39.628] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:84:0)
[15:22:39.628] Timer tick, asking Buildbucket for the build status
[15:22:39.945] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:39.945] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:85:0) after 1m0s
[15:23:40.038] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:85:0)
[15:23:40.038] Timer tick, asking Buildbucket for the build status
[15:23:40.117] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:40.117] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:86:0) after 1m0s
[15:24:40.218] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:86:0)
[15:24:40.218] Timer tick, asking Buildbucket for the build status
[15:24:40.308] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:40.308] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:87:0) after 1m0s
[15:25:40.342] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:87:0)
[15:25:40.342] Timer tick, asking Buildbucket for the build status
[15:25:40.440] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:40.440] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:88:0) after 1m0s
[15:26:40.497] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:88:0)
[15:26:40.497] Timer tick, asking Buildbucket for the build status
[15:26:40.568] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:40.568] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:89:0) after 1m0s
[15:27:40.726] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:89:0)
[15:27:40.726] Timer tick, asking Buildbucket for the build status
[15:27:40.798] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:40.798] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:90:0) after 1m0s
[15:28:40.822] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:90:0)
[15:28:40.822] Timer tick, asking Buildbucket for the build status
[15:28:40.905] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:40.905] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:91:0) after 1m0s
[15:29:40.897] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:91:0)
[15:29:40.897] Timer tick, asking Buildbucket for the build status
[15:29:40.957] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:40.957] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:92:0) after 1m0s
[15:30:40.982] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:92:0)
[15:30:40.982] Timer tick, asking Buildbucket for the build status
[15:30:41.203] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:41.203] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:93:0) after 1m0s
[15:31:41.240] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:93:0)
[15:31:41.240] Timer tick, asking Buildbucket for the build status
[15:31:42.241] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:42.241] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:94:0) after 1m0s
[15:32:42.268] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:94:0)
[15:32:42.268] Timer tick, asking Buildbucket for the build status
[15:32:42.342] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:42.342] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:95:0) after 1m0s
[15:33:42.417] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:95:0)
[15:33:42.417] Timer tick, asking Buildbucket for the build status
[15:33:42.803] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:42.803] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:96:0) after 1m0s
[15:34:42.786] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:96:0)
[15:34:42.786] Timer tick, asking Buildbucket for the build status
[15:34:43.124] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:43.124] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:97:0) after 1m0s
[15:35:43.194] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:97:0)
[15:35:43.194] Timer tick, asking Buildbucket for the build status
[15:35:43.494] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:43.494] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:98:0) after 1m0s
[15:36:43.548] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:98:0)
[15:36:43.548] Timer tick, asking Buildbucket for the build status
[15:36:43.613] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:43.613] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:99:0) after 1m0s
[15:37:43.899] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:99:0)
[15:37:43.899] Timer tick, asking Buildbucket for the build status
[15:37:44.056] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:44.056] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:100:0) after 1m0s
[15:38:44.145] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:100:0)
[15:38:44.145] Timer tick, asking Buildbucket for the build status
[15:38:44.603] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:44.603] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:101:0) after 1m0s
[15:39:44.693] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:101:0)
[15:39:44.693] Timer tick, asking Buildbucket for the build status
[15:39:44.904] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:44.904] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:102:0) after 1m0s
[15:40:44.942] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:102:0)
[15:40:44.942] Timer tick, asking Buildbucket for the build status
[15:40:45.135] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:45.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:103:0) after 1m0s
[15:41:45.280] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:103:0)
[15:41:45.280] Timer tick, asking Buildbucket for the build status
[15:41:45.346] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:45.346] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:104:0) after 1m0s
[15:42:45.404] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:104:0)
[15:42:45.404] Timer tick, asking Buildbucket for the build status
[15:42:45.462] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:45.462] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:105:0) after 1m0s
[15:43:45.613] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:105:0)
[15:43:45.613] Timer tick, asking Buildbucket for the build status
[15:43:45.769] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:45.769] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:106:0) after 1m0s
[15:44:45.802] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:106:0)
[15:44:45.802] Timer tick, asking Buildbucket for the build status
[15:44:45.867] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:45.867] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:107:0) after 1m0s
[15:45:45.945] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:107:0)
[15:45:45.945] Timer tick, asking Buildbucket for the build status
[15:45:46.052] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:46.052] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:108:0) after 1m0s
[15:46:46.207] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:108:0)
[15:46:46.207] Timer tick, asking Buildbucket for the build status
[15:46:46.283] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:46.283] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:109:0) after 1m0s
[15:47:46.334] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:109:0)
[15:47:46.334] Timer tick, asking Buildbucket for the build status
[15:47:46.397] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:46.397] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:110:0) after 1m0s
[15:48:46.513] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:110:0)
[15:48:46.513] Timer tick, asking Buildbucket for the build status
[15:48:46.635] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:46.635] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:111:0) after 1m0s
[15:49:46.670] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:111:0)
[15:49:46.670] Timer tick, asking Buildbucket for the build status
[15:49:46.746] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:46.746] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:112:0) after 1m0s
[15:50:46.906] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:112:0)
[15:50:46.906] Timer tick, asking Buildbucket for the build status
[15:50:47.010] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:47.010] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:113:0) after 1m0s
[15:51:47.077] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:113:0)
[15:51:47.077] Timer tick, asking Buildbucket for the build status
[15:51:47.142] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:47.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:114:0) after 1m0s
[15:52:47.300] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:114:0)
[15:52:47.300] Timer tick, asking Buildbucket for the build status
[15:52:47.367] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:47.367] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:115:0) after 1m0s
[15:53:47.496] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:115:0)
[15:53:47.496] Timer tick, asking Buildbucket for the build status
[15:53:47.711] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:47.711] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:116:0) after 1m0s
[15:54:47.827] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:116:0)
[15:54:47.827] Timer tick, asking Buildbucket for the build status
[15:54:48.046] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:48.046] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:117:0) after 1m0s
[15:55:48.168] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:117:0)
[15:55:48.168] Timer tick, asking Buildbucket for the build status
[15:55:48.327] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:48.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:118:0) after 1m0s
[15:56:48.384] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:118:0)
[15:56:48.384] Timer tick, asking Buildbucket for the build status
[15:56:48.465] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:48.465] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:119:0) after 1m0s
[15:57:48.551] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:119:0)
[15:57:48.551] Timer tick, asking Buildbucket for the build status
[15:57:48.608] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:48.608] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:120:0) after 1m0s
[15:58:48.656] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:120:0)
[15:58:48.656] Timer tick, asking Buildbucket for the build status
[15:58:48.722] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:48.722] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:121:0) after 1m0s
[15:59:48.745] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:121:0)
[15:59:48.745] Timer tick, asking Buildbucket for the build status
[15:59:49.118] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:49.118] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:122:0) after 1m0s
[16:00:49.188] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:122:0)
[16:00:49.189] Timer tick, asking Buildbucket for the build status
[16:00:49.640] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:49.640] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:123:0) after 1m0s
[16:01:49.813] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:123:0)
[16:01:49.813] Timer tick, asking Buildbucket for the build status
[16:01:50.126] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:50.126] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:124:0) after 1m0s
[16:02:50.161] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:124:0)
[16:02:50.161] Timer tick, asking Buildbucket for the build status
[16:02:50.354] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:50.354] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:125:0) after 1m0s
[16:03:50.501] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:125:0)
[16:03:50.501] Timer tick, asking Buildbucket for the build status
[16:03:50.576] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:50.576] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:126:0) after 1m0s
[16:04:50.609] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:126:0)
[16:04:50.609] Timer tick, asking Buildbucket for the build status
[16:04:51.534] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:51.534] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:127:0) after 1m0s
[16:05:51.636] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:127:0)
[16:05:51.636] Timer tick, asking Buildbucket for the build status
[16:05:52.040] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:52.040] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:128:0) after 1m0s
[16:06:52.145] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:128:0)
[16:06:52.145] Timer tick, asking Buildbucket for the build status
[16:06:52.246] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:52.246] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:129:0) after 1m0s
[16:07:52.490] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:129:0)
[16:07:52.490] Timer tick, asking Buildbucket for the build status
[16:07:52.719] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:52.719] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:130:0) after 1m0s
[16:08:52.852] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:130:0)
[16:08:52.852] Timer tick, asking Buildbucket for the build status
[16:08:52.910] Build 8856763842065471584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:52.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022193904141687632:131:0) after 1m0s
[16:09:37.713] Received PubSub notification, asking Buildbucket for the build status
[16:09:37.912] Build 8856763842065471584: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:09:37.912] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1611936577078085",
"created_by": "project:r8",
"created_ts": "1611928819554622",
"id": "8856763842065471584",
"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\": \"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\", \"title\": \"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\", \"url\": \"https://r8.googlesource.com/r8/+/01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\"}}",
"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\": \"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\", \"title\": \"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\", \"url\": \"https://r8.googlesource.com/r8/+/01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\"}]}, \"bot_id\": \"luci-r8-custom-ci-xenial-31-oi2n\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-jdk8\", \"buildnumber\": 423, \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc\", \"test_options\": [\"--runtimes=jdk8\", \"--no_internal\", \"--one_line_per_test\", \"--archive_failures\"]}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_2613c5d12baad4f5401d273916c766f979ef4d581b9bd61b9be1124937285258_v2\", \"builder_6062029f23fdb1fbb8e5450e600b60d86ec5ca9e5dd7ba83c8313df7cdd4c5b0_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-31-oi2n\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611929290457534",
"status": "COMPLETED",
"status_changed_ts": "1611936577456277",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/423",
"builder:linux-jdk8",
"buildset:commit/git/01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/01c374bcb7bf7f8615980b1a0612cbf7bf60c3dc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022193904141687632",
"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/8856763842065471584/+/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:51674362944c0410",
"user_agent:luci-scheduler"
],
"updated_ts": "1611936577468627",
"url": "https://ci.chromium.org/b/8856763842065471584",
"utcnow_ts": "1611936577893905"
}
}
[16:09:37.912] Invocation finished in 2h9m19.721516609s with status SUCCEEDED