[13:30:50.702] New invocation is queued and will start shortly
[13:30:51.799] Starting the invocation (attempt 1)
[13:30:51.830] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:30:51.831] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:30:51.831] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9022286354470199104",
"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\":\"dfca3270c47df6fa7b0006791c8ad920327420b2\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@dfca3270c47df6fa7b0006791c8ad920327420b2\",\"title\":\"dfca3270c47df6fa7b0006791c8ad920327420b2\",\"url\":\"https://r8.googlesource.com/r8/+/dfca3270c47df6fa7b0006791c8ad920327420b2\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"8dfb8d3158ad451e6877a8e9469ae182977a9b61\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@8dfb8d3158ad451e6877a8e9469ae182977a9b61\",\"title\":\"8dfb8d3158ad451e6877a8e9469ae182977a9b61\",\"url\":\"https://r8.googlesource.com/r8/+/8dfb8d3158ad451e6877a8e9469ae182977a9b61\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"8dfb8d3158ad451e6877a8e9469ae182977a9b61\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-jdk8",
"scheduler_invocation_id:9022286354470199104",
"scheduler_job_id:r8/linux-jdk8",
"user_agent:luci-scheduler",
"buildset:commit/git/8dfb8d3158ad451e6877a8e9469ae182977a9b61",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/8dfb8d3158ad451e6877a8e9469ae182977a9b61",
"gitiles_ref:refs/heads/master"
]
}
[13:30:53.513] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1611840652259376",
"id": "8856856292175258576",
"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\": \"dfca3270c47df6fa7b0006791c8ad920327420b2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@dfca3270c47df6fa7b0006791c8ad920327420b2\", \"title\": \"dfca3270c47df6fa7b0006791c8ad920327420b2\", \"url\": \"https://r8.googlesource.com/r8/+/dfca3270c47df6fa7b0006791c8ad920327420b2\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"8dfb8d3158ad451e6877a8e9469ae182977a9b61\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@8dfb8d3158ad451e6877a8e9469ae182977a9b61\", \"title\": \"8dfb8d3158ad451e6877a8e9469ae182977a9b61\", \"url\": \"https://r8.googlesource.com/r8/+/8dfb8d3158ad451e6877a8e9469ae182977a9b61\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"8dfb8d3158ad451e6877a8e9469ae182977a9b61\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611840653147759",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/414",
"builder:linux-jdk8",
"buildset:commit/git/8dfb8d3158ad451e6877a8e9469ae182977a9b61",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/8dfb8d3158ad451e6877a8e9469ae182977a9b61",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022286354470199104",
"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/8856856292175258576/+/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": "1611840653147878",
"url": "https://ci.chromium.org/b/8856856292175258576",
"utcnow_ts": "1611840653467244"
}
}
[13:30:53.513] Task URL: https://ci.chromium.org/b/8856856292175258576
[13:30:53.513] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:2:0) after 1m0s
[13:31:53.616] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:2:0)
[13:31:53.616] Timer tick, asking Buildbucket for the build status
[13:31:53.820] Build 8856856292175258576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:31:53.820] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:3:0) after 1m0s
[13:32:53.904] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:3:0)
[13:32:53.904] Timer tick, asking Buildbucket for the build status
[13:32:54.050] Build 8856856292175258576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:32:54.050] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:4:0) after 1m0s
[13:33:54.144] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:4:0)
[13:33:54.144] Timer tick, asking Buildbucket for the build status
[13:33:54.229] Build 8856856292175258576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:33:54.229] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:5:0) after 1m0s
[13:34:54.276] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:5:0)
[13:34:54.276] Timer tick, asking Buildbucket for the build status
[13:34:54.660] Build 8856856292175258576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:34:54.660] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:6:0) after 1m0s
[13:35:54.678] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:6:0)
[13:35:54.678] Timer tick, asking Buildbucket for the build status
[13:35:54.779] Build 8856856292175258576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:35:54.779] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:7:0) after 1m0s
[13:36:25.713] Received PubSub notification, asking Buildbucket for the build status
[13:36:25.785] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:54.861] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:7:0)
[13:36:54.861] Timer tick, asking Buildbucket for the build status
[13:36:55.338] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:55.338] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:9:0) after 1m0s
[13:37:55.358] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:9:0)
[13:37:55.358] Timer tick, asking Buildbucket for the build status
[13:37:55.687] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:55.687] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:10:0) after 1m0s
[13:38:55.762] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:10:0)
[13:38:55.762] Timer tick, asking Buildbucket for the build status
[13:38:55.834] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:55.834] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:11:0) after 1m0s
[13:39:55.936] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:11:0)
[13:39:55.936] Timer tick, asking Buildbucket for the build status
[13:39:56.667] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:56.667] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:12:0) after 1m0s
[13:40:56.731] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:12:0)
[13:40:56.731] Timer tick, asking Buildbucket for the build status
[13:40:56.848] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:56.848] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:13:0) after 1m0s
[13:41:56.942] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:13:0)
[13:41:56.942] Timer tick, asking Buildbucket for the build status
[13:41:57.125] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:57.125] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:14:0) after 1m0s
[13:42:57.194] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:14:0)
[13:42:57.194] Timer tick, asking Buildbucket for the build status
[13:42:57.306] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:57.306] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:15:0) after 1m0s
[13:43:57.347] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:15:0)
[13:43:57.347] Timer tick, asking Buildbucket for the build status
[13:43:57.420] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:57.420] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:16:0) after 1m0s
[13:44:57.487] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:16:0)
[13:44:57.487] Timer tick, asking Buildbucket for the build status
[13:44:57.563] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:57.563] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:17:0) after 1m0s
[13:45:57.691] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:17:0)
[13:45:57.691] Timer tick, asking Buildbucket for the build status
[13:45:57.816] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:57.816] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:18:0) after 1m0s
[13:46:57.871] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:18:0)
[13:46:57.871] Timer tick, asking Buildbucket for the build status
[13:46:57.968] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:57.968] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:19:0) after 1m0s
[13:47:58.073] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:19:0)
[13:47:58.073] Timer tick, asking Buildbucket for the build status
[13:47:58.136] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:58.136] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:20:0) after 1m0s
[13:48:58.203] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:20:0)
[13:48:58.203] Timer tick, asking Buildbucket for the build status
[13:48:58.268] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:58.268] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:21:0) after 1m0s
[13:49:58.351] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:21:0)
[13:49:58.351] Timer tick, asking Buildbucket for the build status
[13:49:58.432] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:58.432] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:22:0) after 1m0s
[13:50:58.450] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:22:0)
[13:50:58.450] Timer tick, asking Buildbucket for the build status
[13:50:58.555] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:58.555] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:23:0) after 1m0s
[13:51:58.614] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:23:0)
[13:51:58.614] Timer tick, asking Buildbucket for the build status
[13:51:58.699] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:58.699] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:24:0) after 1m0s
[13:52:58.742] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:24:0)
[13:52:58.742] Timer tick, asking Buildbucket for the build status
[13:52:58.806] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:58.806] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:25:0) after 1m0s
[13:53:58.854] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:25:0)
[13:53:58.854] Timer tick, asking Buildbucket for the build status
[13:53:58.955] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:58.955] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:26:0) after 1m0s
[13:54:58.987] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:26:0)
[13:54:58.987] Timer tick, asking Buildbucket for the build status
[13:54:59.044] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:59.044] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:27:0) after 1m0s
[13:55:59.115] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:27:0)
[13:55:59.115] Timer tick, asking Buildbucket for the build status
[13:55:59.235] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:59.235] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:28:0) after 1m0s
[13:56:59.355] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:28:0)
[13:56:59.355] Timer tick, asking Buildbucket for the build status
[13:56:59.524] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:59.524] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:29:0) after 1m0s
[13:57:59.615] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:29:0)
[13:57:59.616] Timer tick, asking Buildbucket for the build status
[13:57:59.702] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:59.702] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:30:0) after 1m0s
[13:58:59.785] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:30:0)
[13:58:59.785] Timer tick, asking Buildbucket for the build status
[13:59:00.146] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:00.146] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:31:0) after 1m0s
[14:00:00.344] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:31:0)
[14:00:00.344] Timer tick, asking Buildbucket for the build status
[14:00:00.423] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:00.423] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:32:0) after 1m0s
[14:01:00.523] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:32:0)
[14:01:00.523] Timer tick, asking Buildbucket for the build status
[14:01:00.664] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:00.664] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:33:0) after 1m0s
[14:02:00.841] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:33:0)
[14:02:00.841] Timer tick, asking Buildbucket for the build status
[14:02:00.959] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:00.959] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:34:0) after 1m0s
[14:03:01.601] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:34:0)
[14:03:01.601] Timer tick, asking Buildbucket for the build status
[14:03:01.922] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:01.922] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:35:0) after 1m0s
[14:04:03.367] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:35:0)
[14:04:03.367] Timer tick, asking Buildbucket for the build status
[14:04:03.440] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:03.440] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:36:0) after 1m0s
[14:05:03.531] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:36:0)
[14:05:03.531] Timer tick, asking Buildbucket for the build status
[14:05:03.686] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:03.686] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:37:0) after 1m0s
[14:06:03.811] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:37:0)
[14:06:03.811] Timer tick, asking Buildbucket for the build status
[14:06:04.886] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:04.886] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:38:0) after 1m0s
[14:07:05.228] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:38:0)
[14:07:05.228] Timer tick, asking Buildbucket for the build status
[14:07:05.312] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:05.312] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:39:0) after 1m0s
[14:08:05.631] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:39:0)
[14:08:05.631] Timer tick, asking Buildbucket for the build status
[14:08:05.774] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:05.774] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:40:0) after 1m0s
[14:09:05.793] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:40:0)
[14:09:05.793] Timer tick, asking Buildbucket for the build status
[14:09:05.856] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:05.856] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:41:0) after 1m0s
[14:10:05.909] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:41:0)
[14:10:05.909] Timer tick, asking Buildbucket for the build status
[14:10:05.984] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:05.984] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:42:0) after 1m0s
[14:11:06.136] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:42:0)
[14:11:06.136] Timer tick, asking Buildbucket for the build status
[14:11:06.509] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:06.509] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:43:0) after 1m0s
[14:12:06.530] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:43:0)
[14:12:06.530] Timer tick, asking Buildbucket for the build status
[14:12:06.624] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:06.624] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:44:0) after 1m0s
[14:13:06.701] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:44:0)
[14:13:06.701] Timer tick, asking Buildbucket for the build status
[14:13:06.992] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:06.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:45:0) after 1m0s
[14:14:07.210] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:45:0)
[14:14:07.210] Timer tick, asking Buildbucket for the build status
[14:14:07.442] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:07.442] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:46:0) after 1m0s
[14:15:07.501] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:46:0)
[14:15:07.501] Timer tick, asking Buildbucket for the build status
[14:15:07.577] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:07.577] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:47:0) after 1m0s
[14:16:07.853] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:47:0)
[14:16:07.853] Timer tick, asking Buildbucket for the build status
[14:16:08.004] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:08.004] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:48:0) after 1m0s
[14:17:08.309] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:48:0)
[14:17:08.309] Timer tick, asking Buildbucket for the build status
[14:17:08.437] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:08.437] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:49:0) after 1m0s
[14:18:08.669] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:49:0)
[14:18:08.669] Timer tick, asking Buildbucket for the build status
[14:18:09.202] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:09.202] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:50:0) after 1m0s
[14:19:09.337] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:50:0)
[14:19:09.337] Timer tick, asking Buildbucket for the build status
[14:19:09.417] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:09.417] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:51:0) after 1m0s
[14:20:09.561] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:51:0)
[14:20:09.561] Timer tick, asking Buildbucket for the build status
[14:20:09.648] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:09.648] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:52:0) after 1m0s
[14:21:09.718] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:52:0)
[14:21:09.718] Timer tick, asking Buildbucket for the build status
[14:21:09.969] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:09.969] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:53:0) after 1m0s
[14:22:10.385] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:53:0)
[14:22:10.385] Timer tick, asking Buildbucket for the build status
[14:22:10.475] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:10.475] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:54:0) after 1m0s
[14:23:10.693] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:54:0)
[14:23:10.693] Timer tick, asking Buildbucket for the build status
[14:23:10.785] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:10.785] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:55:0) after 1m0s
[14:24:10.838] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:55:0)
[14:24:10.838] Timer tick, asking Buildbucket for the build status
[14:24:11.109] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:11.109] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:56:0) after 1m0s
[14:25:11.206] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:56:0)
[14:25:11.206] Timer tick, asking Buildbucket for the build status
[14:25:11.278] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:11.278] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:57:0) after 1m0s
[14:26:11.309] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:57:0)
[14:26:11.309] Timer tick, asking Buildbucket for the build status
[14:26:11.478] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:11.478] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:58:0) after 1m0s
[14:27:11.455] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:58:0)
[14:27:11.455] Timer tick, asking Buildbucket for the build status
[14:27:11.535] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:11.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:59:0) after 1m0s
[14:28:11.602] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:59:0)
[14:28:11.602] Timer tick, asking Buildbucket for the build status
[14:28:11.711] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:11.711] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:60:0) after 1m0s
[14:29:11.842] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:60:0)
[14:29:11.842] Timer tick, asking Buildbucket for the build status
[14:29:12.010] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:12.010] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:61:0) after 1m0s
[14:30:12.066] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:61:0)
[14:30:12.066] Timer tick, asking Buildbucket for the build status
[14:30:12.180] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:12.180] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:62:0) after 1m0s
[14:31:12.208] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:62:0)
[14:31:12.208] Timer tick, asking Buildbucket for the build status
[14:31:13.137] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:13.137] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:63:0) after 1m0s
[14:32:13.221] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:63:0)
[14:32:13.221] Timer tick, asking Buildbucket for the build status
[14:32:13.407] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:13.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:64:0) after 1m0s
[14:33:13.428] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:64:0)
[14:33:13.428] Timer tick, asking Buildbucket for the build status
[14:33:13.762] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:13.762] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:65:0) after 1m0s
[14:34:13.830] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:65:0)
[14:34:13.830] Timer tick, asking Buildbucket for the build status
[14:34:13.911] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:13.911] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:66:0) after 1m0s
[14:35:13.977] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:66:0)
[14:35:13.977] Timer tick, asking Buildbucket for the build status
[14:35:14.133] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:14.133] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:67:0) after 1m0s
[14:36:14.128] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:67:0)
[14:36:14.128] Timer tick, asking Buildbucket for the build status
[14:36:14.930] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:14.930] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:68:0) after 1m0s
[14:37:14.970] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:68:0)
[14:37:14.970] Timer tick, asking Buildbucket for the build status
[14:37:15.078] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:15.078] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:69:0) after 1m0s
[14:38:15.108] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:69:0)
[14:38:15.108] Timer tick, asking Buildbucket for the build status
[14:38:15.188] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:15.188] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:70:0) after 1m0s
[14:39:15.236] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:70:0)
[14:39:15.236] Timer tick, asking Buildbucket for the build status
[14:39:15.296] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:15.296] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:71:0) after 1m0s
[14:40:15.379] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:71:0)
[14:40:15.379] Timer tick, asking Buildbucket for the build status
[14:40:15.547] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:15.547] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:72:0) after 1m0s
[14:41:15.660] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:72:0)
[14:41:15.660] Timer tick, asking Buildbucket for the build status
[14:41:15.777] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:15.777] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:73:0) after 1m0s
[14:42:15.801] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:73:0)
[14:42:15.801] Timer tick, asking Buildbucket for the build status
[14:42:16.156] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:16.156] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:74:0) after 1m0s
[14:43:16.168] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:74:0)
[14:43:16.168] Timer tick, asking Buildbucket for the build status
[14:43:16.262] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:16.262] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:75:0) after 1m0s
[14:44:16.302] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:75:0)
[14:44:16.302] Timer tick, asking Buildbucket for the build status
[14:44:16.382] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:16.383] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:76:0) after 1m0s
[14:45:16.456] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:76:0)
[14:45:16.456] Timer tick, asking Buildbucket for the build status
[14:45:16.540] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:16.540] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:77:0) after 1m0s
[14:46:16.607] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:77:0)
[14:46:16.607] Timer tick, asking Buildbucket for the build status
[14:46:16.842] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:16.842] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:78:0) after 1m0s
[14:47:16.933] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:78:0)
[14:47:16.933] Timer tick, asking Buildbucket for the build status
[14:47:17.142] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:17.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:79:0) after 1m0s
[14:48:17.348] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:79:0)
[14:48:17.348] Timer tick, asking Buildbucket for the build status
[14:48:17.488] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:17.488] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:80:0) after 1m0s
[14:49:17.608] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:80:0)
[14:49:17.608] Timer tick, asking Buildbucket for the build status
[14:49:17.672] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:17.672] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:81:0) after 1m0s
[14:50:17.697] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:81:0)
[14:50:17.697] Timer tick, asking Buildbucket for the build status
[14:50:17.947] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:17.947] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:82:0) after 1m0s
[14:51:18.062] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:82:0)
[14:51:18.062] Timer tick, asking Buildbucket for the build status
[14:51:18.323] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:18.323] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:83:0) after 1m0s
[14:52:18.383] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:83:0)
[14:52:18.383] Timer tick, asking Buildbucket for the build status
[14:52:18.462] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:18.462] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:84:0) after 1m0s
[14:53:18.526] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:84:0)
[14:53:18.526] Timer tick, asking Buildbucket for the build status
[14:53:18.669] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:18.669] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:85:0) after 1m0s
[14:54:19.125] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:85:0)
[14:54:19.125] Timer tick, asking Buildbucket for the build status
[14:54:19.352] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:19.352] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:86:0) after 1m0s
[14:55:19.492] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:86:0)
[14:55:19.492] Timer tick, asking Buildbucket for the build status
[14:55:19.637] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:19.637] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:87:0) after 1m0s
[14:56:19.764] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:87:0)
[14:56:19.764] Timer tick, asking Buildbucket for the build status
[14:56:20.488] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:20.488] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:88:0) after 1m0s
[14:57:20.605] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:88:0)
[14:57:20.605] Timer tick, asking Buildbucket for the build status
[14:57:20.681] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:20.681] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:89:0) after 1m0s
[14:58:20.744] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:89:0)
[14:58:20.744] Timer tick, asking Buildbucket for the build status
[14:58:20.810] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:20.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:90:0) after 1m0s
[14:59:20.861] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:90:0)
[14:59:20.861] Timer tick, asking Buildbucket for the build status
[14:59:20.952] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:20.952] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:91:0) after 1m0s
[15:00:21.086] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:91:0)
[15:00:21.086] Timer tick, asking Buildbucket for the build status
[15:00:21.172] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:21.172] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:92:0) after 1m0s
[15:01:21.258] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:92:0)
[15:01:21.258] Timer tick, asking Buildbucket for the build status
[15:01:22.580] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:22.580] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:93:0) after 1m0s
[15:02:22.603] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:93:0)
[15:02:22.603] Timer tick, asking Buildbucket for the build status
[15:02:22.797] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:22.797] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:94:0) after 1m0s
[15:03:22.849] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:94:0)
[15:03:22.849] Timer tick, asking Buildbucket for the build status
[15:03:22.925] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:22.926] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:95:0) after 1m0s
[15:04:22.978] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:95:0)
[15:04:22.978] Timer tick, asking Buildbucket for the build status
[15:04:23.067] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:23.067] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:96:0) after 1m0s
[15:05:23.155] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:96:0)
[15:05:23.155] Timer tick, asking Buildbucket for the build status
[15:05:23.239] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:23.239] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:97:0) after 1m0s
[15:06:23.280] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:97:0)
[15:06:23.280] Timer tick, asking Buildbucket for the build status
[15:06:23.406] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:23.406] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:98:0) after 1m0s
[15:07:23.446] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:98:0)
[15:07:23.446] Timer tick, asking Buildbucket for the build status
[15:07:23.533] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:23.533] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:99:0) after 1m0s
[15:08:23.554] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:99:0)
[15:08:23.554] Timer tick, asking Buildbucket for the build status
[15:08:23.873] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:23.873] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:100:0) after 1m0s
[15:09:23.899] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:100:0)
[15:09:23.899] Timer tick, asking Buildbucket for the build status
[15:09:24.007] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:24.007] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:101:0) after 1m0s
[15:10:24.086] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:101:0)
[15:10:24.086] Timer tick, asking Buildbucket for the build status
[15:10:24.181] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:24.181] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:102:0) after 1m0s
[15:11:25.294] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:102:0)
[15:11:25.294] Timer tick, asking Buildbucket for the build status
[15:11:25.383] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:25.384] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:103:0) after 1m0s
[15:12:25.883] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:103:0)
[15:12:25.883] Timer tick, asking Buildbucket for the build status
[15:12:26.032] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:26.032] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:104:0) after 1m0s
[15:13:26.588] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:104:0)
[15:13:26.588] Timer tick, asking Buildbucket for the build status
[15:13:26.668] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:26.668] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:105:0) after 1m0s
[15:14:27.086] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:105:0)
[15:14:27.086] Timer tick, asking Buildbucket for the build status
[15:14:27.145] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:27.145] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:106:0) after 1m0s
[15:15:27.445] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:106:0)
[15:15:27.445] Timer tick, asking Buildbucket for the build status
[15:15:27.509] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:27.509] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:107:0) after 1m0s
[15:16:28.007] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:107:0)
[15:16:28.007] Timer tick, asking Buildbucket for the build status
[15:16:28.368] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:28.368] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:108:0) after 1m0s
[15:17:28.596] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:108:0)
[15:17:28.596] Timer tick, asking Buildbucket for the build status
[15:17:29.554] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:29.554] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:109:0) after 1m0s
[15:18:29.965] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:109:0)
[15:18:29.965] Timer tick, asking Buildbucket for the build status
[15:18:30.065] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:30.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:110:0) after 1m0s
[15:19:30.326] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:110:0)
[15:19:30.326] Timer tick, asking Buildbucket for the build status
[15:19:30.426] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:30.426] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:111:0) after 1m0s
[15:20:30.547] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:111:0)
[15:20:30.547] Timer tick, asking Buildbucket for the build status
[15:20:30.618] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:30.618] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:112:0) after 1m0s
[15:21:30.809] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:112:0)
[15:21:30.809] Timer tick, asking Buildbucket for the build status
[15:21:31.632] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:31.632] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:113:0) after 1m0s
[15:22:31.772] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:113:0)
[15:22:31.772] Timer tick, asking Buildbucket for the build status
[15:22:32.017] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:32.017] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:114:0) after 1m0s
[15:23:32.100] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:114:0)
[15:23:32.100] Timer tick, asking Buildbucket for the build status
[15:23:32.544] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:32.544] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:115:0) after 1m0s
[15:24:32.643] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:115:0)
[15:24:32.643] Timer tick, asking Buildbucket for the build status
[15:24:33.533] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:33.533] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:116:0) after 1m0s
[15:25:33.592] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:116:0)
[15:25:33.592] Timer tick, asking Buildbucket for the build status
[15:25:33.681] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:33.681] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:117:0) after 1m0s
[15:26:33.736] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:117:0)
[15:26:33.736] Timer tick, asking Buildbucket for the build status
[15:26:33.876] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:33.876] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:118:0) after 1m0s
[15:27:33.902] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:118:0)
[15:27:33.902] Timer tick, asking Buildbucket for the build status
[15:27:33.970] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:33.970] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:119:0) after 1m0s
[15:28:34.047] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:119:0)
[15:28:34.047] Timer tick, asking Buildbucket for the build status
[15:28:34.284] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:34.284] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:120:0) after 1m0s
[15:29:34.301] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:120:0)
[15:29:34.301] Timer tick, asking Buildbucket for the build status
[15:29:34.404] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:34.404] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:121:0) after 1m0s
[15:30:34.595] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:121:0)
[15:30:34.595] Timer tick, asking Buildbucket for the build status
[15:30:34.704] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:34.704] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:122:0) after 1m0s
[15:31:34.766] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:122:0)
[15:31:34.766] Timer tick, asking Buildbucket for the build status
[15:31:34.877] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:34.877] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:123:0) after 1m0s
[15:32:34.925] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:123:0)
[15:32:34.925] Timer tick, asking Buildbucket for the build status
[15:32:35.171] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:35.171] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:124:0) after 1m0s
[15:33:36.336] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:124:0)
[15:33:36.336] Timer tick, asking Buildbucket for the build status
[15:33:36.605] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:36.605] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:125:0) after 1m0s
[15:34:36.690] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:125:0)
[15:34:36.690] Timer tick, asking Buildbucket for the build status
[15:34:36.759] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:36.759] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:126:0) after 1m0s
[15:35:36.799] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:126:0)
[15:35:36.799] Timer tick, asking Buildbucket for the build status
[15:35:36.910] Build 8856856292175258576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:36.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9022286354470199104:127:0) after 1m0s
[15:35:43.506] Received PubSub notification, asking Buildbucket for the build status
[15:35:43.583] Build 8856856292175258576: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:35:43.583] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1611848142624832",
"created_by": "project:r8",
"created_ts": "1611840652259376",
"id": "8856856292175258576",
"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\": \"dfca3270c47df6fa7b0006791c8ad920327420b2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@dfca3270c47df6fa7b0006791c8ad920327420b2\", \"title\": \"dfca3270c47df6fa7b0006791c8ad920327420b2\", \"url\": \"https://r8.googlesource.com/r8/+/dfca3270c47df6fa7b0006791c8ad920327420b2\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"8dfb8d3158ad451e6877a8e9469ae182977a9b61\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@8dfb8d3158ad451e6877a8e9469ae182977a9b61\", \"title\": \"8dfb8d3158ad451e6877a8e9469ae182977a9b61\", \"url\": \"https://r8.googlesource.com/r8/+/8dfb8d3158ad451e6877a8e9469ae182977a9b61\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"8dfb8d3158ad451e6877a8e9469ae182977a9b61\"}}",
"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\": \"dfca3270c47df6fa7b0006791c8ad920327420b2\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@dfca3270c47df6fa7b0006791c8ad920327420b2\", \"title\": \"dfca3270c47df6fa7b0006791c8ad920327420b2\", \"url\": \"https://r8.googlesource.com/r8/+/dfca3270c47df6fa7b0006791c8ad920327420b2\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"8dfb8d3158ad451e6877a8e9469ae182977a9b61\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@8dfb8d3158ad451e6877a8e9469ae182977a9b61\", \"title\": \"8dfb8d3158ad451e6877a8e9469ae182977a9b61\", \"url\": \"https://r8.googlesource.com/r8/+/8dfb8d3158ad451e6877a8e9469ae182977a9b61\"}]}, \"bot_id\": \"luci-r8-custom-ci-xenial-1-y3v8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-jdk8\", \"buildnumber\": 414, \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"8dfb8d3158ad451e6877a8e9469ae182977a9b61\", \"test_options\": [\"--runtimes=jdk8\", \"--no_internal\", \"--one_line_per_test\", \"--archive_failures\"]}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_eb7e387c4303b06d97795eee82c01b95ab00910dec9228d92bdbe3520ae1adfa_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-1-y3v8\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"normal\": [\"true\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.r8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611840985063803",
"status": "COMPLETED",
"status_changed_ts": "1611848142964252",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/414",
"builder:linux-jdk8",
"buildset:commit/git/8dfb8d3158ad451e6877a8e9469ae182977a9b61",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/8dfb8d3158ad451e6877a8e9469ae182977a9b61",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022286354470199104",
"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/8856856292175258576/+/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:516202122151b610",
"user_agent:luci-scheduler"
],
"updated_ts": "1611848143084307",
"url": "https://ci.chromium.org/b/8856856292175258576",
"utcnow_ts": "1611848143571668"
}
}
[15:35:43.584] Invocation finished in 2h4m52.896950452s with status SUCCEEDED