[15:35:52.703] New invocation is queued and will start shortly
[15:35:53.782] Starting the invocation (attempt 1)
[15:35:53.831] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:35:53.831] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:35:53.831] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9026174157626795200",
"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\":\"3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\",\"title\":\"3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\",\"url\":\"https://r8.googlesource.com/r8/+/3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"d5954de5fe3af86dc61db5f869f1d218718ef8f2\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@d5954de5fe3af86dc61db5f869f1d218718ef8f2\",\"title\":\"d5954de5fe3af86dc61db5f869f1d218718ef8f2\",\"url\":\"https://r8.googlesource.com/r8/+/d5954de5fe3af86dc61db5f869f1d218718ef8f2\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"95d26d63b158906598dcf50fb495b7d6657df34b\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@95d26d63b158906598dcf50fb495b7d6657df34b\",\"title\":\"95d26d63b158906598dcf50fb495b7d6657df34b\",\"url\":\"https://r8.googlesource.com/r8/+/95d26d63b158906598dcf50fb495b7d6657df34b\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"95d26d63b158906598dcf50fb495b7d6657df34b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-jdk8",
"scheduler_invocation_id:9026174157626795200",
"scheduler_job_id:r8/linux-jdk8",
"user_agent:luci-scheduler",
"buildset:commit/git/95d26d63b158906598dcf50fb495b7d6657df34b",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/95d26d63b158906598dcf50fb495b7d6657df34b",
"gitiles_ref:refs/heads/master"
]
}
[15:35:54.995] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1608132953947914",
"id": "8860744095639804672",
"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\": \"3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\", \"title\": \"3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\", \"url\": \"https://r8.googlesource.com/r8/+/3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"d5954de5fe3af86dc61db5f869f1d218718ef8f2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@d5954de5fe3af86dc61db5f869f1d218718ef8f2\", \"title\": \"d5954de5fe3af86dc61db5f869f1d218718ef8f2\", \"url\": \"https://r8.googlesource.com/r8/+/d5954de5fe3af86dc61db5f869f1d218718ef8f2\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"95d26d63b158906598dcf50fb495b7d6657df34b\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@95d26d63b158906598dcf50fb495b7d6657df34b\", \"title\": \"95d26d63b158906598dcf50fb495b7d6657df34b\", \"url\": \"https://r8.googlesource.com/r8/+/95d26d63b158906598dcf50fb495b7d6657df34b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"95d26d63b158906598dcf50fb495b7d6657df34b\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608132954660052",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/274",
"builder:linux-jdk8",
"buildset:commit/git/95d26d63b158906598dcf50fb495b7d6657df34b",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/95d26d63b158906598dcf50fb495b7d6657df34b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026174157626795200",
"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/8860744095639804672/+/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": "1608132954660165",
"url": "https://ci.chromium.org/b/8860744095639804672",
"utcnow_ts": "1608132954931750"
}
}
[15:35:54.995] Task URL: https://ci.chromium.org/b/8860744095639804672
[15:35:54.995] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:2:0) after 1m0s
[15:36:18.301] Received PubSub notification, asking Buildbucket for the build status
[15:36:18.366] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:55.160] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:2:0)
[15:36:55.160] Timer tick, asking Buildbucket for the build status
[15:36:55.770] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:55.770] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:4:0) after 1m0s
[15:37:55.821] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:4:0)
[15:37:55.821] Timer tick, asking Buildbucket for the build status
[15:37:55.928] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:55.928] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:5:0) after 1m0s
[15:38:55.977] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:5:0)
[15:38:55.977] Timer tick, asking Buildbucket for the build status
[15:38:56.067] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:56.067] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:6:0) after 1m0s
[15:39:56.132] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:6:0)
[15:39:56.132] Timer tick, asking Buildbucket for the build status
[15:39:56.205] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:56.205] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:7:0) after 1m0s
[15:40:56.269] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:7:0)
[15:40:56.269] Timer tick, asking Buildbucket for the build status
[15:40:56.515] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:56.515] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:8:0) after 1m0s
[15:41:56.546] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:8:0)
[15:41:56.546] Timer tick, asking Buildbucket for the build status
[15:41:56.889] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:56.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:9:0) after 1m0s
[15:42:56.909] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:9:0)
[15:42:56.909] Timer tick, asking Buildbucket for the build status
[15:42:56.989] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:56.989] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:10:0) after 1m0s
[15:43:57.023] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:10:0)
[15:43:57.023] Timer tick, asking Buildbucket for the build status
[15:43:57.183] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:57.183] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:11:0) after 1m0s
[15:44:57.235] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:11:0)
[15:44:57.235] Timer tick, asking Buildbucket for the build status
[15:44:57.345] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:57.345] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:12:0) after 1m0s
[15:45:57.368] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:12:0)
[15:45:57.368] Timer tick, asking Buildbucket for the build status
[15:45:57.924] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:57.924] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:13:0) after 1m0s
[15:46:58.027] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:13:0)
[15:46:58.027] Timer tick, asking Buildbucket for the build status
[15:46:58.102] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:58.102] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:14:0) after 1m0s
[15:47:58.186] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:14:0)
[15:47:58.186] Timer tick, asking Buildbucket for the build status
[15:47:58.319] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:58.319] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:15:0) after 1m0s
[15:48:59.107] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:15:0)
[15:48:59.107] Timer tick, asking Buildbucket for the build status
[15:48:59.187] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:59.187] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:16:0) after 1m0s
[15:49:59.273] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:16:0)
[15:49:59.274] Timer tick, asking Buildbucket for the build status
[15:49:59.348] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:59.348] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:17:0) after 1m0s
[15:50:59.499] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:17:0)
[15:50:59.499] Timer tick, asking Buildbucket for the build status
[15:50:59.618] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:59.618] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:18:0) after 1m0s
[15:51:59.841] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:18:0)
[15:51:59.841] Timer tick, asking Buildbucket for the build status
[15:51:59.914] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:59.914] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:19:0) after 1m0s
[15:53:00.130] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:19:0)
[15:53:00.130] Timer tick, asking Buildbucket for the build status
[15:53:00.241] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:00.241] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:20:0) after 1m0s
[15:54:01.099] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:20:0)
[15:54:01.099] Timer tick, asking Buildbucket for the build status
[15:54:01.267] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:01.267] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:21:0) after 1m0s
[15:55:01.498] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:21:0)
[15:55:01.498] Timer tick, asking Buildbucket for the build status
[15:55:01.701] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:01.701] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:22:0) after 1m0s
[15:56:01.806] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:22:0)
[15:56:01.807] Timer tick, asking Buildbucket for the build status
[15:56:02.107] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:02.107] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:23:0) after 1m0s
[15:57:02.277] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:23:0)
[15:57:02.277] Timer tick, asking Buildbucket for the build status
[15:57:02.347] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:02.347] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:24:0) after 1m0s
[15:58:02.416] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:24:0)
[15:58:02.416] Timer tick, asking Buildbucket for the build status
[15:58:02.482] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:02.482] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:25:0) after 1m0s
[15:59:02.691] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:25:0)
[15:59:02.691] Timer tick, asking Buildbucket for the build status
[15:59:02.758] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:02.758] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:26:0) after 1m0s
[16:00:02.965] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:26:0)
[16:00:02.965] Timer tick, asking Buildbucket for the build status
[16:00:03.037] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:03.037] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:27:0) after 1m0s
[16:01:03.073] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:27:0)
[16:01:03.073] Timer tick, asking Buildbucket for the build status
[16:01:03.756] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:03.756] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:28:0) after 1m0s
[16:02:03.814] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:28:0)
[16:02:03.814] Timer tick, asking Buildbucket for the build status
[16:02:03.895] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:03.895] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:29:0) after 1m0s
[16:03:04.054] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:29:0)
[16:03:04.054] Timer tick, asking Buildbucket for the build status
[16:03:04.127] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:04.127] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:30:0) after 1m0s
[16:04:04.186] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:30:0)
[16:04:04.186] Timer tick, asking Buildbucket for the build status
[16:04:04.425] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:04.425] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:31:0) after 1m0s
[16:05:04.536] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:31:0)
[16:05:04.536] Timer tick, asking Buildbucket for the build status
[16:05:04.686] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:04.686] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:32:0) after 1m0s
[16:06:04.720] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:32:0)
[16:06:04.720] Timer tick, asking Buildbucket for the build status
[16:06:04.861] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:04.861] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:33:0) after 1m0s
[16:07:04.863] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:33:0)
[16:07:04.863] Timer tick, asking Buildbucket for the build status
[16:07:05.057] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:05.057] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:34:0) after 1m0s
[16:08:05.097] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:34:0)
[16:08:05.097] Timer tick, asking Buildbucket for the build status
[16:08:05.351] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:05.351] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:35:0) after 1m0s
[16:09:05.377] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:35:0)
[16:09:05.377] Timer tick, asking Buildbucket for the build status
[16:09:05.607] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:05.607] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:36:0) after 1m0s
[16:10:05.706] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:36:0)
[16:10:05.706] Timer tick, asking Buildbucket for the build status
[16:10:05.829] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:05.829] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:37:0) after 1m0s
[16:11:05.828] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:37:0)
[16:11:05.828] Timer tick, asking Buildbucket for the build status
[16:11:05.973] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:05.973] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:38:0) after 1m0s
[16:12:06.010] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:38:0)
[16:12:06.010] Timer tick, asking Buildbucket for the build status
[16:12:06.108] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:06.108] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:39:0) after 1m0s
[16:13:06.185] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:39:0)
[16:13:06.185] Timer tick, asking Buildbucket for the build status
[16:13:06.257] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:06.257] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:40:0) after 1m0s
[16:14:06.368] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:40:0)
[16:14:06.368] Timer tick, asking Buildbucket for the build status
[16:14:07.206] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:07.206] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:41:0) after 1m0s
[16:15:07.264] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:41:0)
[16:15:07.264] Timer tick, asking Buildbucket for the build status
[16:15:07.353] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:07.353] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:42:0) after 1m0s
[16:16:07.396] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:42:0)
[16:16:07.396] Timer tick, asking Buildbucket for the build status
[16:16:07.907] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:07.907] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:43:0) after 1m0s
[16:17:08.016] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:43:0)
[16:17:08.016] Timer tick, asking Buildbucket for the build status
[16:17:08.087] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:08.087] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:44:0) after 1m0s
[16:18:08.168] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:44:0)
[16:18:08.168] Timer tick, asking Buildbucket for the build status
[16:18:08.236] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:08.236] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:45:0) after 1m0s
[16:19:08.255] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:45:0)
[16:19:08.255] Timer tick, asking Buildbucket for the build status
[16:19:08.482] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:08.482] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:46:0) after 1m0s
[16:20:08.529] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:46:0)
[16:20:08.529] Timer tick, asking Buildbucket for the build status
[16:20:08.586] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:08.586] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:47:0) after 1m0s
[16:21:08.622] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:47:0)
[16:21:08.622] Timer tick, asking Buildbucket for the build status
[16:21:08.740] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:08.740] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:48:0) after 1m0s
[16:22:08.784] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:48:0)
[16:22:08.784] Timer tick, asking Buildbucket for the build status
[16:22:08.859] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:08.859] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:49:0) after 1m0s
[16:23:08.879] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:49:0)
[16:23:08.879] Timer tick, asking Buildbucket for the build status
[16:23:09.029] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:09.029] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:50:0) after 1m0s
[16:24:09.133] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:50:0)
[16:24:09.133] Timer tick, asking Buildbucket for the build status
[16:24:09.208] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:09.208] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:51:0) after 1m0s
[16:25:09.257] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:51:0)
[16:25:09.257] Timer tick, asking Buildbucket for the build status
[16:25:09.346] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:09.346] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:52:0) after 1m0s
[16:26:09.477] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:52:0)
[16:26:09.477] Timer tick, asking Buildbucket for the build status
[16:26:09.832] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:09.832] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:53:0) after 1m0s
[16:27:09.895] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:53:0)
[16:27:09.895] Timer tick, asking Buildbucket for the build status
[16:27:09.963] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:09.963] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:54:0) after 1m0s
[16:28:09.987] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:54:0)
[16:28:09.987] Timer tick, asking Buildbucket for the build status
[16:28:10.062] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:10.062] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:55:0) after 1m0s
[16:29:10.122] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:55:0)
[16:29:10.122] Timer tick, asking Buildbucket for the build status
[16:29:10.327] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:10.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:56:0) after 1m0s
[16:30:10.392] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:56:0)
[16:30:10.392] Timer tick, asking Buildbucket for the build status
[16:30:10.643] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:10.643] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:57:0) after 1m0s
[16:31:10.692] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:57:0)
[16:31:10.692] Timer tick, asking Buildbucket for the build status
[16:31:10.788] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:10.788] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:58:0) after 1m0s
[16:32:10.945] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:58:0)
[16:32:10.945] Timer tick, asking Buildbucket for the build status
[16:32:11.048] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:11.048] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:59:0) after 1m0s
[16:33:11.224] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:59:0)
[16:33:11.224] Timer tick, asking Buildbucket for the build status
[16:33:11.442] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:11.442] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:60:0) after 1m0s
[16:34:11.430] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:60:0)
[16:34:11.430] Timer tick, asking Buildbucket for the build status
[16:34:11.520] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:11.520] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:61:0) after 1m0s
[16:35:11.614] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:61:0)
[16:35:11.614] Timer tick, asking Buildbucket for the build status
[16:35:11.687] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:11.687] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:62:0) after 1m0s
[16:36:11.812] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:62:0)
[16:36:11.812] Timer tick, asking Buildbucket for the build status
[16:36:12.020] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:12.020] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:63:0) after 1m0s
[16:37:12.076] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:63:0)
[16:37:12.076] Timer tick, asking Buildbucket for the build status
[16:37:12.233] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:12.233] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:64:0) after 1m0s
[16:38:12.236] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:64:0)
[16:38:12.236] Timer tick, asking Buildbucket for the build status
[16:38:12.333] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:12.333] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:65:0) after 1m0s
[16:39:12.422] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:65:0)
[16:39:12.422] Timer tick, asking Buildbucket for the build status
[16:39:12.703] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:12.703] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:66:0) after 1m0s
[16:40:12.732] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:66:0)
[16:40:12.732] Timer tick, asking Buildbucket for the build status
[16:40:12.873] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:12.873] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:67:0) after 1m0s
[16:41:13.054] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:67:0)
[16:41:13.054] Timer tick, asking Buildbucket for the build status
[16:41:13.157] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:13.157] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:68:0) after 1m0s
[16:42:13.337] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:68:0)
[16:42:13.337] Timer tick, asking Buildbucket for the build status
[16:42:13.443] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:13.443] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:69:0) after 1m0s
[16:43:14.283] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:69:0)
[16:43:14.283] Timer tick, asking Buildbucket for the build status
[16:43:14.529] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:14.529] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:70:0) after 1m0s
[16:44:15.136] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:70:0)
[16:44:15.136] Timer tick, asking Buildbucket for the build status
[16:44:15.409] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:15.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:71:0) after 1m0s
[16:45:15.436] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:71:0)
[16:45:15.436] Timer tick, asking Buildbucket for the build status
[16:45:15.497] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:15.497] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:72:0) after 1m0s
[16:46:15.675] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:72:0)
[16:46:15.675] Timer tick, asking Buildbucket for the build status
[16:46:15.906] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:15.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:73:0) after 1m0s
[16:47:16.037] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:73:0)
[16:47:16.037] Timer tick, asking Buildbucket for the build status
[16:47:16.317] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:16.317] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:74:0) after 1m0s
[16:48:16.449] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:74:0)
[16:48:16.449] Timer tick, asking Buildbucket for the build status
[16:48:16.554] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:16.554] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:75:0) after 1m0s
[16:49:16.924] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:75:0)
[16:49:16.924] Timer tick, asking Buildbucket for the build status
[16:49:17.106] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:17.106] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:76:0) after 1m0s
[16:50:17.192] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:76:0)
[16:50:17.192] Timer tick, asking Buildbucket for the build status
[16:50:17.267] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:17.267] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:77:0) after 1m0s
[16:51:17.613] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:77:0)
[16:51:17.613] Timer tick, asking Buildbucket for the build status
[16:51:17.734] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:17.734] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:78:0) after 1m0s
[16:52:17.998] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:78:0)
[16:52:17.998] Timer tick, asking Buildbucket for the build status
[16:52:18.347] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:18.347] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:79:0) after 1m0s
[16:53:18.658] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:79:0)
[16:53:18.658] Timer tick, asking Buildbucket for the build status
[16:53:18.731] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:18.731] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:80:0) after 1m0s
[16:54:18.799] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:80:0)
[16:54:18.800] Timer tick, asking Buildbucket for the build status
[16:54:18.901] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:18.901] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:81:0) after 1m0s
[16:55:19.127] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:81:0)
[16:55:19.127] Timer tick, asking Buildbucket for the build status
[16:55:19.208] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:19.208] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:82:0) after 1m0s
[16:56:19.292] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:82:0)
[16:56:19.292] Timer tick, asking Buildbucket for the build status
[16:56:19.476] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:19.476] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:83:0) after 1m0s
[16:57:19.576] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:83:0)
[16:57:19.576] Timer tick, asking Buildbucket for the build status
[16:57:20.261] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:20.261] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:84:0) after 1m0s
[16:58:20.274] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:84:0)
[16:58:20.274] Timer tick, asking Buildbucket for the build status
[16:58:20.362] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:20.362] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:85:0) after 1m0s
[16:59:20.397] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:85:0)
[16:59:20.397] Timer tick, asking Buildbucket for the build status
[16:59:20.942] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:20.943] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:86:0) after 1m0s
[17:00:21.011] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:86:0)
[17:00:21.011] Timer tick, asking Buildbucket for the build status
[17:00:21.479] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:21.480] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:87:0) after 1m0s
[17:01:21.504] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:87:0)
[17:01:21.504] Timer tick, asking Buildbucket for the build status
[17:01:21.925] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:21.925] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:88:0) after 1m0s
[17:02:21.931] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:88:0)
[17:02:21.931] Timer tick, asking Buildbucket for the build status
[17:02:22.186] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:22.186] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:89:0) after 1m0s
[17:03:22.226] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:89:0)
[17:03:22.226] Timer tick, asking Buildbucket for the build status
[17:03:22.464] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:22.464] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:90:0) after 1m0s
[17:04:22.532] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:90:0)
[17:04:22.532] Timer tick, asking Buildbucket for the build status
[17:04:22.813] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:22.814] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:91:0) after 1m0s
[17:05:22.933] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:91:0)
[17:05:22.933] Timer tick, asking Buildbucket for the build status
[17:05:24.626] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:24.626] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:92:0) after 1m0s
[17:06:24.685] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:92:0)
[17:06:24.685] Timer tick, asking Buildbucket for the build status
[17:06:24.824] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:24.824] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:93:0) after 1m0s
[17:07:24.881] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:93:0)
[17:07:24.881] Timer tick, asking Buildbucket for the build status
[17:07:24.961] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:24.961] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:94:0) after 1m0s
[17:08:24.968] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:94:0)
[17:08:24.968] Timer tick, asking Buildbucket for the build status
[17:08:25.033] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:25.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:95:0) after 1m0s
[17:09:25.110] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:95:0)
[17:09:25.110] Timer tick, asking Buildbucket for the build status
[17:09:25.175] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:25.175] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:96:0) after 1m0s
[17:10:25.222] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:96:0)
[17:10:25.222] Timer tick, asking Buildbucket for the build status
[17:10:25.282] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:25.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:97:0) after 1m0s
[17:11:25.345] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:97:0)
[17:11:25.345] Timer tick, asking Buildbucket for the build status
[17:11:25.702] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:25.702] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:98:0) after 1m0s
[17:12:25.918] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:98:0)
[17:12:25.918] Timer tick, asking Buildbucket for the build status
[17:12:26.002] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:26.002] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:99:0) after 1m0s
[17:13:26.081] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:99:0)
[17:13:26.081] Timer tick, asking Buildbucket for the build status
[17:13:26.414] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:26.414] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:100:0) after 1m0s
[17:14:26.532] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:100:0)
[17:14:26.532] Timer tick, asking Buildbucket for the build status
[17:14:26.607] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:26.607] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:101:0) after 1m0s
[17:15:26.708] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:101:0)
[17:15:26.708] Timer tick, asking Buildbucket for the build status
[17:15:26.804] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:26.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:102:0) after 1m0s
[17:16:26.867] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:102:0)
[17:16:26.868] Timer tick, asking Buildbucket for the build status
[17:16:26.997] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:26.997] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:103:0) after 1m0s
[17:17:27.003] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:103:0)
[17:17:27.003] Timer tick, asking Buildbucket for the build status
[17:17:27.158] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:27.158] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:104:0) after 1m0s
[17:18:27.260] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:104:0)
[17:18:27.260] Timer tick, asking Buildbucket for the build status
[17:18:27.344] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:27.344] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:105:0) after 1m0s
[17:19:27.405] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:105:0)
[17:19:27.405] Timer tick, asking Buildbucket for the build status
[17:19:27.531] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:27.531] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:106:0) after 1m0s
[17:20:27.733] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:106:0)
[17:20:27.733] Timer tick, asking Buildbucket for the build status
[17:20:27.804] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:27.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:107:0) after 1m0s
[17:21:27.938] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:107:0)
[17:21:27.938] Timer tick, asking Buildbucket for the build status
[17:21:29.087] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:29.087] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:108:0) after 1m0s
[17:22:29.367] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:108:0)
[17:22:29.367] Timer tick, asking Buildbucket for the build status
[17:22:29.446] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:29.446] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:109:0) after 1m0s
[17:23:29.630] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:109:0)
[17:23:29.630] Timer tick, asking Buildbucket for the build status
[17:23:29.847] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:29.847] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:110:0) after 1m0s
[17:24:30.373] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:110:0)
[17:24:30.373] Timer tick, asking Buildbucket for the build status
[17:24:30.466] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:30.466] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:111:0) after 1m0s
[17:25:30.773] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:111:0)
[17:25:30.773] Timer tick, asking Buildbucket for the build status
[17:25:30.835] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:30.835] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:112:0) after 1m0s
[17:26:30.948] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:112:0)
[17:26:30.948] Timer tick, asking Buildbucket for the build status
[17:26:31.122] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:31.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:113:0) after 1m0s
[17:27:31.212] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:113:0)
[17:27:31.212] Timer tick, asking Buildbucket for the build status
[17:27:31.298] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:31.298] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:114:0) after 1m0s
[17:28:31.412] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:114:0)
[17:28:31.412] Timer tick, asking Buildbucket for the build status
[17:28:31.479] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:31.479] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:115:0) after 1m0s
[17:29:31.719] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:115:0)
[17:29:31.719] Timer tick, asking Buildbucket for the build status
[17:29:31.800] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:31.800] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:116:0) after 1m0s
[17:30:31.858] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:116:0)
[17:30:31.858] Timer tick, asking Buildbucket for the build status
[17:30:32.246] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:32.246] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:117:0) after 1m0s
[17:31:32.329] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:117:0)
[17:31:32.329] Timer tick, asking Buildbucket for the build status
[17:31:32.449] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:32.449] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:118:0) after 1m0s
[17:32:32.523] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:118:0)
[17:32:32.523] Timer tick, asking Buildbucket for the build status
[17:32:33.112] Build 8860744095639804672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:33.112] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9026174157626795200:119:0) after 1m0s
[17:32:35.549] Received PubSub notification, asking Buildbucket for the build status
[17:32:35.622] Build 8860744095639804672: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:32:35.622] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1608139954619312",
"created_by": "project:r8",
"created_ts": "1608132953947914",
"id": "8860744095639804672",
"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\": \"3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\", \"title\": \"3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\", \"url\": \"https://r8.googlesource.com/r8/+/3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"d5954de5fe3af86dc61db5f869f1d218718ef8f2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@d5954de5fe3af86dc61db5f869f1d218718ef8f2\", \"title\": \"d5954de5fe3af86dc61db5f869f1d218718ef8f2\", \"url\": \"https://r8.googlesource.com/r8/+/d5954de5fe3af86dc61db5f869f1d218718ef8f2\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"95d26d63b158906598dcf50fb495b7d6657df34b\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@95d26d63b158906598dcf50fb495b7d6657df34b\", \"title\": \"95d26d63b158906598dcf50fb495b7d6657df34b\", \"url\": \"https://r8.googlesource.com/r8/+/95d26d63b158906598dcf50fb495b7d6657df34b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"95d26d63b158906598dcf50fb495b7d6657df34b\"}}",
"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\": \"3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\", \"title\": \"3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\", \"url\": \"https://r8.googlesource.com/r8/+/3c6d769b7bef3f3d3b44a9647785fd6b5ccd5589\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"d5954de5fe3af86dc61db5f869f1d218718ef8f2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@d5954de5fe3af86dc61db5f869f1d218718ef8f2\", \"title\": \"d5954de5fe3af86dc61db5f869f1d218718ef8f2\", \"url\": \"https://r8.googlesource.com/r8/+/d5954de5fe3af86dc61db5f869f1d218718ef8f2\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"95d26d63b158906598dcf50fb495b7d6657df34b\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@95d26d63b158906598dcf50fb495b7d6657df34b\", \"title\": \"95d26d63b158906598dcf50fb495b7d6657df34b\", \"url\": \"https://r8.googlesource.com/r8/+/95d26d63b158906598dcf50fb495b7d6657df34b\"}]}, \"bot_id\": \"luci-r8-custom-ci-xenial-34-b0sc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-jdk8\", \"buildnumber\": 274, \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"95d26d63b158906598dcf50fb495b7d6657df34b\", \"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-34-b0sc\"], \"image\": [\"chrome-xenial-20121300-d43316a0aad\"], \"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\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608132975582809",
"status": "COMPLETED",
"status_changed_ts": "1608139954966401",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/274",
"builder:linux-jdk8",
"buildset:commit/git/95d26d63b158906598dcf50fb495b7d6657df34b",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/95d26d63b158906598dcf50fb495b7d6657df34b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026174157626795200",
"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/8860744095639804672/+/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:5085031635d79310",
"user_agent:luci-scheduler"
],
"updated_ts": "1608139954995788",
"url": "https://ci.chromium.org/b/8860744095639804672",
"utcnow_ts": "1608139955612792"
}
}
[17:32:35.622] Invocation finished in 1h56m42.953151523s with status SUCCEEDED