[13:26:28.771] New invocation is queued and will start shortly
[13:26:30.011] Starting the invocation (attempt 1)
[13:26:30.053] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:26:30.054] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:26:30.054] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9024098568455566112",
"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\":\"d064a4bac25285d89412d25bbc704957d0c094b7\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@d064a4bac25285d89412d25bbc704957d0c094b7\",\"title\":\"d064a4bac25285d89412d25bbc704957d0c094b7\",\"url\":\"https://r8.googlesource.com/r8/+/d064a4bac25285d89412d25bbc704957d0c094b7\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"d064a4bac25285d89412d25bbc704957d0c094b7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-jdk8",
"scheduler_invocation_id:9024098568455566112",
"scheduler_job_id:r8/linux-jdk8",
"user_agent:luci-scheduler",
"buildset:commit/git/d064a4bac25285d89412d25bbc704957d0c094b7",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/d064a4bac25285d89412d25bbc704957d0c094b7",
"gitiles_ref:refs/heads/master"
]
}
[13:26:30.849] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1610112390142367",
"id": "8858668506352562208",
"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\": \"d064a4bac25285d89412d25bbc704957d0c094b7\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@d064a4bac25285d89412d25bbc704957d0c094b7\", \"title\": \"d064a4bac25285d89412d25bbc704957d0c094b7\", \"url\": \"https://r8.googlesource.com/r8/+/d064a4bac25285d89412d25bbc704957d0c094b7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"d064a4bac25285d89412d25bbc704957d0c094b7\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610112390573993",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/325",
"builder:linux-jdk8",
"buildset:commit/git/d064a4bac25285d89412d25bbc704957d0c094b7",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/d064a4bac25285d89412d25bbc704957d0c094b7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024098568455566112",
"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/8858668506352562208/+/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": "1610112390574109",
"url": "https://ci.chromium.org/b/8858668506352562208",
"utcnow_ts": "1610112390839509"
}
}
[13:26:30.849] Task URL: https://ci.chromium.org/b/8858668506352562208
[13:26:30.849] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:2:0) after 1m0s
[13:26:43.248] Received PubSub notification, asking Buildbucket for the build status
[13:26:43.307] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:30.910] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:2:0)
[13:27:30.910] Timer tick, asking Buildbucket for the build status
[13:27:31.042] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:31.042] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:4:0) after 1m0s
[13:28:31.111] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:4:0)
[13:28:31.111] Timer tick, asking Buildbucket for the build status
[13:28:31.172] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:31.172] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:5:0) after 1m0s
[13:29:31.215] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:5:0)
[13:29:31.215] Timer tick, asking Buildbucket for the build status
[13:29:31.293] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:31.293] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:6:0) after 1m0s
[13:30:31.363] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:6:0)
[13:30:31.363] Timer tick, asking Buildbucket for the build status
[13:30:31.435] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:31.435] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:7:0) after 1m0s
[13:31:31.556] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:7:0)
[13:31:31.556] Timer tick, asking Buildbucket for the build status
[13:31:31.634] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:31.634] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:8:0) after 1m0s
[13:32:31.779] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:8:0)
[13:32:31.779] Timer tick, asking Buildbucket for the build status
[13:32:31.913] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:31.913] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:9:0) after 1m0s
[13:33:32.040] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:9:0)
[13:33:32.040] Timer tick, asking Buildbucket for the build status
[13:33:32.118] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:32.118] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:10:0) after 1m0s
[13:34:32.262] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:10:0)
[13:34:32.262] Timer tick, asking Buildbucket for the build status
[13:34:32.316] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:32.316] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:11:0) after 1m0s
[13:35:32.457] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:11:0)
[13:35:32.457] Timer tick, asking Buildbucket for the build status
[13:35:32.608] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:32.608] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:12:0) after 1m0s
[13:36:32.695] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:12:0)
[13:36:32.695] Timer tick, asking Buildbucket for the build status
[13:36:32.792] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:32.792] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:13:0) after 1m0s
[13:37:32.800] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:13:0)
[13:37:32.800] Timer tick, asking Buildbucket for the build status
[13:37:33.185] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:33.185] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:14:0) after 1m0s
[13:38:33.310] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:14:0)
[13:38:33.311] Timer tick, asking Buildbucket for the build status
[13:38:33.381] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:33.381] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:15:0) after 1m0s
[13:39:33.386] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:15:0)
[13:39:33.386] Timer tick, asking Buildbucket for the build status
[13:39:33.473] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:33.473] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:16:0) after 1m0s
[13:40:33.537] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:16:0)
[13:40:33.537] Timer tick, asking Buildbucket for the build status
[13:40:33.597] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:33.597] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:17:0) after 1m0s
[13:41:33.628] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:17:0)
[13:41:33.628] Timer tick, asking Buildbucket for the build status
[13:41:33.681] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:33.681] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:18:0) after 1m0s
[13:42:33.810] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:18:0)
[13:42:33.810] Timer tick, asking Buildbucket for the build status
[13:42:33.907] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:33.907] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:19:0) after 1m0s
[13:43:34.034] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:19:0)
[13:43:34.034] Timer tick, asking Buildbucket for the build status
[13:43:34.138] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:34.138] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:20:0) after 1m0s
[13:44:34.263] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:20:0)
[13:44:34.263] Timer tick, asking Buildbucket for the build status
[13:44:34.326] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:34.326] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:21:0) after 1m0s
[13:45:34.381] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:21:0)
[13:45:34.381] Timer tick, asking Buildbucket for the build status
[13:45:34.632] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:34.632] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:22:0) after 1m0s
[13:46:34.760] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:22:0)
[13:46:34.760] Timer tick, asking Buildbucket for the build status
[13:46:35.131] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:35.131] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:23:0) after 1m0s
[13:47:35.295] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:23:0)
[13:47:35.295] Timer tick, asking Buildbucket for the build status
[13:47:35.526] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:35.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:24:0) after 1m0s
[13:48:35.970] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:24:0)
[13:48:35.970] Timer tick, asking Buildbucket for the build status
[13:48:36.095] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:36.095] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:25:0) after 1m0s
[13:49:36.180] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:25:0)
[13:49:36.180] Timer tick, asking Buildbucket for the build status
[13:49:36.241] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:36.241] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:26:0) after 1m0s
[13:50:36.255] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:26:0)
[13:50:36.255] Timer tick, asking Buildbucket for the build status
[13:50:36.435] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:36.435] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:27:0) after 1m0s
[13:51:36.502] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:27:0)
[13:51:36.502] Timer tick, asking Buildbucket for the build status
[13:51:36.574] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:36.574] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:28:0) after 1m0s
[13:52:36.691] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:28:0)
[13:52:36.691] Timer tick, asking Buildbucket for the build status
[13:52:36.989] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:36.989] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:29:0) after 1m0s
[13:53:37.117] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:29:0)
[13:53:37.117] Timer tick, asking Buildbucket for the build status
[13:53:37.226] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:37.226] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:30:0) after 1m0s
[13:54:37.352] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:30:0)
[13:54:37.352] Timer tick, asking Buildbucket for the build status
[13:54:37.418] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:37.418] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:31:0) after 1m0s
[13:55:37.494] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:31:0)
[13:55:37.494] Timer tick, asking Buildbucket for the build status
[13:55:37.548] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:37.548] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:32:0) after 1m0s
[13:56:37.551] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:32:0)
[13:56:37.551] Timer tick, asking Buildbucket for the build status
[13:56:37.594] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:37.594] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:33:0) after 1m0s
[13:57:37.582] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:33:0)
[13:57:37.582] Timer tick, asking Buildbucket for the build status
[13:57:37.892] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:37.892] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:34:0) after 1m0s
[13:58:37.945] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:34:0)
[13:58:37.945] Timer tick, asking Buildbucket for the build status
[13:58:38.011] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:38.011] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:35:0) after 1m0s
[13:59:38.041] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:35:0)
[13:59:38.041] Timer tick, asking Buildbucket for the build status
[13:59:38.092] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:38.093] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:36:0) after 1m0s
[14:00:38.235] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:36:0)
[14:00:38.235] Timer tick, asking Buildbucket for the build status
[14:00:38.326] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:38.326] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:37:0) after 1m0s
[14:01:38.455] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:37:0)
[14:01:38.455] Timer tick, asking Buildbucket for the build status
[14:01:38.537] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:38.537] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:38:0) after 1m0s
[14:02:38.613] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:38:0)
[14:02:38.613] Timer tick, asking Buildbucket for the build status
[14:02:38.801] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:38.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:39:0) after 1m0s
[14:03:38.898] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:39:0)
[14:03:38.898] Timer tick, asking Buildbucket for the build status
[14:03:39.219] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:39.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:40:0) after 1m0s
[14:04:39.275] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:40:0)
[14:04:39.275] Timer tick, asking Buildbucket for the build status
[14:04:39.357] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:39.357] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:41:0) after 1m0s
[14:05:39.374] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:41:0)
[14:05:39.374] Timer tick, asking Buildbucket for the build status
[14:05:39.432] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:39.432] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:42:0) after 1m0s
[14:06:39.456] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:42:0)
[14:06:39.456] Timer tick, asking Buildbucket for the build status
[14:06:39.598] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:39.598] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:43:0) after 1m0s
[14:07:39.673] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:43:0)
[14:07:39.673] Timer tick, asking Buildbucket for the build status
[14:07:39.733] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:39.733] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:44:0) after 1m0s
[14:08:39.775] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:44:0)
[14:08:39.775] Timer tick, asking Buildbucket for the build status
[14:08:39.853] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:39.853] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:45:0) after 1m0s
[14:09:39.911] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:45:0)
[14:09:39.911] Timer tick, asking Buildbucket for the build status
[14:09:39.990] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:39.990] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:46:0) after 1m0s
[14:10:40.138] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:46:0)
[14:10:40.138] Timer tick, asking Buildbucket for the build status
[14:10:40.415] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:40.415] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:47:0) after 1m0s
[14:11:40.500] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:47:0)
[14:11:40.500] Timer tick, asking Buildbucket for the build status
[14:11:40.584] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:40.584] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:48:0) after 1m0s
[14:12:40.624] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:48:0)
[14:12:40.624] Timer tick, asking Buildbucket for the build status
[14:12:40.718] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:40.718] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:49:0) after 1m0s
[14:13:40.817] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:49:0)
[14:13:40.817] Timer tick, asking Buildbucket for the build status
[14:13:40.881] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:40.881] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:50:0) after 1m0s
[14:14:40.919] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:50:0)
[14:14:40.919] Timer tick, asking Buildbucket for the build status
[14:14:41.002] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:41.002] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:51:0) after 1m0s
[14:15:41.065] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:51:0)
[14:15:41.065] Timer tick, asking Buildbucket for the build status
[14:15:41.451] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:41.451] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:52:0) after 1m0s
[14:16:41.546] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:52:0)
[14:16:41.546] Timer tick, asking Buildbucket for the build status
[14:16:41.974] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:41.974] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:53:0) after 1m0s
[14:17:41.992] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:53:0)
[14:17:41.992] Timer tick, asking Buildbucket for the build status
[14:17:42.063] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:42.063] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:54:0) after 1m0s
[14:18:42.041] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:54:0)
[14:18:42.041] Timer tick, asking Buildbucket for the build status
[14:18:42.116] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:42.116] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:55:0) after 1m0s
[14:19:42.155] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:55:0)
[14:19:42.155] Timer tick, asking Buildbucket for the build status
[14:19:42.223] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:42.223] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:56:0) after 1m0s
[14:20:42.258] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:56:0)
[14:20:42.258] Timer tick, asking Buildbucket for the build status
[14:20:42.316] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:42.316] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:57:0) after 1m0s
[14:21:42.301] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:57:0)
[14:21:42.301] Timer tick, asking Buildbucket for the build status
[14:21:42.446] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:42.446] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:58:0) after 1m0s
[14:22:42.507] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:58:0)
[14:22:42.507] Timer tick, asking Buildbucket for the build status
[14:22:42.568] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:42.568] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:59:0) after 1m0s
[14:23:42.615] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:59:0)
[14:23:42.615] Timer tick, asking Buildbucket for the build status
[14:23:42.678] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:42.678] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:60:0) after 1m0s
[14:24:42.699] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:60:0)
[14:24:42.699] Timer tick, asking Buildbucket for the build status
[14:24:42.762] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:42.762] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:61:0) after 1m0s
[14:25:42.802] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:61:0)
[14:25:42.802] Timer tick, asking Buildbucket for the build status
[14:25:42.869] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:42.869] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:62:0) after 1m0s
[14:26:42.925] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:62:0)
[14:26:42.925] Timer tick, asking Buildbucket for the build status
[14:26:43.035] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:43.035] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:63:0) after 1m0s
[14:27:43.036] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:63:0)
[14:27:43.036] Timer tick, asking Buildbucket for the build status
[14:27:43.092] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:43.092] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:64:0) after 1m0s
[14:28:43.153] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:64:0)
[14:28:43.153] Timer tick, asking Buildbucket for the build status
[14:28:43.219] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:43.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:65:0) after 1m0s
[14:29:43.285] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:65:0)
[14:29:43.285] Timer tick, asking Buildbucket for the build status
[14:29:43.513] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:43.513] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:66:0) after 1m0s
[14:30:43.589] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:66:0)
[14:30:43.589] Timer tick, asking Buildbucket for the build status
[14:30:43.654] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:43.654] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:67:0) after 1m0s
[14:31:43.652] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:67:0)
[14:31:43.652] Timer tick, asking Buildbucket for the build status
[14:31:43.923] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:43.923] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:68:0) after 1m0s
[14:32:43.986] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:68:0)
[14:32:43.986] Timer tick, asking Buildbucket for the build status
[14:32:44.048] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:44.048] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:69:0) after 1m0s
[14:33:44.078] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:69:0)
[14:33:44.078] Timer tick, asking Buildbucket for the build status
[14:33:44.136] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:44.136] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:70:0) after 1m0s
[14:34:44.162] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:70:0)
[14:34:44.162] Timer tick, asking Buildbucket for the build status
[14:34:44.256] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:44.256] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:71:0) after 1m0s
[14:35:44.413] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:71:0)
[14:35:44.413] Timer tick, asking Buildbucket for the build status
[14:35:44.474] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:44.474] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:72:0) after 1m0s
[14:36:44.602] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:72:0)
[14:36:44.602] Timer tick, asking Buildbucket for the build status
[14:36:44.716] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:44.716] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:73:0) after 1m0s
[14:37:44.877] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:73:0)
[14:37:44.877] Timer tick, asking Buildbucket for the build status
[14:37:45.077] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:45.077] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:74:0) after 1m0s
[14:38:45.177] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:74:0)
[14:38:45.177] Timer tick, asking Buildbucket for the build status
[14:38:45.491] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:45.491] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:75:0) after 1m0s
[14:39:45.615] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:75:0)
[14:39:45.615] Timer tick, asking Buildbucket for the build status
[14:39:45.661] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:45.661] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:76:0) after 1m0s
[14:40:45.751] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:76:0)
[14:40:45.751] Timer tick, asking Buildbucket for the build status
[14:40:45.812] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:45.812] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:77:0) after 1m0s
[14:41:45.786] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:77:0)
[14:41:45.786] Timer tick, asking Buildbucket for the build status
[14:41:45.947] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:45.947] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:78:0) after 1m0s
[14:42:46.022] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:78:0)
[14:42:46.022] Timer tick, asking Buildbucket for the build status
[14:42:46.102] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:46.102] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:79:0) after 1m0s
[14:43:46.221] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:79:0)
[14:43:46.221] Timer tick, asking Buildbucket for the build status
[14:43:46.274] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:46.274] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:80:0) after 1m0s
[14:44:46.493] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:80:0)
[14:44:46.493] Timer tick, asking Buildbucket for the build status
[14:44:46.548] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:46.548] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:81:0) after 1m0s
[14:45:46.639] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:81:0)
[14:45:46.639] Timer tick, asking Buildbucket for the build status
[14:45:46.726] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:46.726] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:82:0) after 1m0s
[14:46:46.882] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:82:0)
[14:46:46.882] Timer tick, asking Buildbucket for the build status
[14:46:46.992] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:46.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:83:0) after 1m0s
[14:47:47.187] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:83:0)
[14:47:47.187] Timer tick, asking Buildbucket for the build status
[14:47:47.262] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:47.262] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:84:0) after 1m0s
[14:48:47.286] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:84:0)
[14:48:47.286] Timer tick, asking Buildbucket for the build status
[14:48:47.392] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:47.392] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:85:0) after 1m0s
[14:49:47.416] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:85:0)
[14:49:47.416] Timer tick, asking Buildbucket for the build status
[14:49:47.921] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:47.921] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:86:0) after 1m0s
[14:50:47.954] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:86:0)
[14:50:47.954] Timer tick, asking Buildbucket for the build status
[14:50:48.017] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:48.017] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:87:0) after 1m0s
[14:51:48.097] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:87:0)
[14:51:48.097] Timer tick, asking Buildbucket for the build status
[14:51:48.212] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:48.212] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:88:0) after 1m0s
[14:52:48.266] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:88:0)
[14:52:48.266] Timer tick, asking Buildbucket for the build status
[14:52:48.542] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:48.542] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:89:0) after 1m0s
[14:53:48.611] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:89:0)
[14:53:48.611] Timer tick, asking Buildbucket for the build status
[14:53:48.712] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:48.712] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:90:0) after 1m0s
[14:54:48.717] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:90:0)
[14:54:48.717] Timer tick, asking Buildbucket for the build status
[14:54:48.783] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:48.783] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:91:0) after 1m0s
[14:55:48.829] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:91:0)
[14:55:48.829] Timer tick, asking Buildbucket for the build status
[14:55:48.889] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:48.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:92:0) after 1m0s
[14:56:49.031] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:92:0)
[14:56:49.031] Timer tick, asking Buildbucket for the build status
[14:56:49.132] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:49.132] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:93:0) after 1m0s
[14:57:49.234] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:93:0)
[14:57:49.234] Timer tick, asking Buildbucket for the build status
[14:57:49.380] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:49.380] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:94:0) after 1m0s
[14:58:49.384] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:94:0)
[14:58:49.384] Timer tick, asking Buildbucket for the build status
[14:58:49.445] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:49.445] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:95:0) after 1m0s
[14:59:49.476] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:95:0)
[14:59:49.476] Timer tick, asking Buildbucket for the build status
[14:59:49.548] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:49.548] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:96:0) after 1m0s
[15:00:49.723] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:96:0)
[15:00:49.723] Timer tick, asking Buildbucket for the build status
[15:00:49.797] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:49.797] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:97:0) after 1m0s
[15:01:49.916] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:97:0)
[15:01:49.916] Timer tick, asking Buildbucket for the build status
[15:01:50.311] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:50.311] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:98:0) after 1m0s
[15:02:50.471] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:98:0)
[15:02:50.471] Timer tick, asking Buildbucket for the build status
[15:02:50.535] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:50.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:99:0) after 1m0s
[15:03:50.678] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:99:0)
[15:03:50.678] Timer tick, asking Buildbucket for the build status
[15:03:50.901] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:50.901] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:100:0) after 1m0s
[15:04:51.012] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:100:0)
[15:04:51.012] Timer tick, asking Buildbucket for the build status
[15:04:51.379] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:51.379] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:101:0) after 1m0s
[15:05:51.428] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:101:0)
[15:05:51.428] Timer tick, asking Buildbucket for the build status
[15:05:51.533] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:51.533] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:102:0) after 1m0s
[15:06:55.020] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:102:0)
[15:06:55.020] Timer tick, asking Buildbucket for the build status
[15:06:55.130] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:55.130] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:103:0) after 1m0s
[15:07:57.639] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:103:0)
[15:07:57.639] Timer tick, asking Buildbucket for the build status
[15:07:57.735] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:57.735] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:104:0) after 1m0s
[15:08:57.788] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:104:0)
[15:08:57.788] Timer tick, asking Buildbucket for the build status
[15:08:57.859] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:57.859] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:105:0) after 1m0s
[15:09:57.884] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:105:0)
[15:09:57.884] Timer tick, asking Buildbucket for the build status
[15:09:57.941] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:57.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:106:0) after 1m0s
[15:10:57.989] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:106:0)
[15:10:57.989] Timer tick, asking Buildbucket for the build status
[15:10:58.055] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:58.055] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:107:0) after 1m0s
[15:11:58.228] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:107:0)
[15:11:58.228] Timer tick, asking Buildbucket for the build status
[15:11:58.348] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:58.348] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:108:0) after 1m0s
[15:12:58.361] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:108:0)
[15:12:58.361] Timer tick, asking Buildbucket for the build status
[15:12:58.428] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:58.429] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:109:0) after 1m0s
[15:13:58.504] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:109:0)
[15:13:58.504] Timer tick, asking Buildbucket for the build status
[15:13:58.709] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:58.709] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:110:0) after 1m0s
[15:14:58.779] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:110:0)
[15:14:58.779] Timer tick, asking Buildbucket for the build status
[15:14:58.835] Build 8858668506352562208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:58.835] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024098568455566112:111:0) after 1m0s
[15:15:14.652] Received PubSub notification, asking Buildbucket for the build status
[15:15:14.825] Build 8858668506352562208: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:15:14.825] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1610118914023602",
"created_by": "project:r8",
"created_ts": "1610112390142367",
"failure_reason": "BUILD_FAILURE",
"id": "8858668506352562208",
"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\": \"d064a4bac25285d89412d25bbc704957d0c094b7\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@d064a4bac25285d89412d25bbc704957d0c094b7\", \"title\": \"d064a4bac25285d89412d25bbc704957d0c094b7\", \"url\": \"https://r8.googlesource.com/r8/+/d064a4bac25285d89412d25bbc704957d0c094b7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"d064a4bac25285d89412d25bbc704957d0c094b7\"}}",
"project": "r8",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('Run tests') (retcode: 1)\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"d064a4bac25285d89412d25bbc704957d0c094b7\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@d064a4bac25285d89412d25bbc704957d0c094b7\", \"title\": \"d064a4bac25285d89412d25bbc704957d0c094b7\", \"url\": \"https://r8.googlesource.com/r8/+/d064a4bac25285d89412d25bbc704957d0c094b7\"}]}, \"bot_id\": \"luci-r8-custom-ci-xenial-14-1wc9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-jdk8\", \"buildnumber\": 325, \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"d064a4bac25285d89412d25bbc704957d0c094b7\", \"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-14-1wc9\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}, \"ui\": {\"info\": \"Step('Run tests') (retcode: 1)\"}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610112401900954",
"status": "COMPLETED",
"status_changed_ts": "1610112402646173",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/325",
"builder:linux-jdk8",
"buildset:commit/git/d064a4bac25285d89412d25bbc704957d0c094b7",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/d064a4bac25285d89412d25bbc704957d0c094b7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024098568455566112",
"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/8858668506352562208/+/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:50fafef4cd619010",
"user_agent:luci-scheduler"
],
"updated_ts": "1610118914245003",
"url": "https://ci.chromium.org/b/8858668506352562208",
"utcnow_ts": "1610118914813178"
}
}
[15:15:14.825] Invocation finished in 1h48m46.071947493s with status FAILED