[13:24:25.785] New invocation is queued and will start shortly
[13:24:27.226] Starting the invocation (attempt 1)
[13:24:27.273] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:24:27.273] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:24:27.273] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9029534515402182288",
"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\":\"aed5e6c28fb85c82633622bb15bf2e087e64daa1\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@aed5e6c28fb85c82633622bb15bf2e087e64daa1\",\"title\":\"aed5e6c28fb85c82633622bb15bf2e087e64daa1\",\"url\":\"https://r8.googlesource.com/r8/+/aed5e6c28fb85c82633622bb15bf2e087e64daa1\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"aed5e6c28fb85c82633622bb15bf2e087e64daa1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-jdk8",
"scheduler_invocation_id:9029534515402182288",
"scheduler_job_id:r8/linux-jdk8",
"user_agent:luci-scheduler",
"buildset:commit/git/aed5e6c28fb85c82633622bb15bf2e087e64daa1",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/aed5e6c28fb85c82633622bb15bf2e087e64daa1",
"gitiles_ref:refs/heads/master"
]
}
[13:24:28.098] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:r8",
"created_ts": "1604928267377557",
"id": "8864104453064878560",
"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\": \"aed5e6c28fb85c82633622bb15bf2e087e64daa1\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@aed5e6c28fb85c82633622bb15bf2e087e64daa1\", \"title\": \"aed5e6c28fb85c82633622bb15bf2e087e64daa1\", \"url\": \"https://r8.googlesource.com/r8/+/aed5e6c28fb85c82633622bb15bf2e087e64daa1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"aed5e6c28fb85c82633622bb15bf2e087e64daa1\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604928267943389",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/99",
"builder:linux-jdk8",
"buildset:commit/git/aed5e6c28fb85c82633622bb15bf2e087e64daa1",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/aed5e6c28fb85c82633622bb15bf2e087e64daa1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029534515402182288",
"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/8864104453064878560/+/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": "1604928267943867",
"url": "https://ci.chromium.org/b/8864104453064878560",
"utcnow_ts": "1604928268087719"
}
}
[13:24:28.098] Task URL: https://ci.chromium.org/b/8864104453064878560
[13:24:28.098] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:2:0) after 1m0s
[13:25:09.365] Received PubSub notification, asking Buildbucket for the build status
[13:25:09.450] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:28.157] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:2:0)
[13:25:28.157] Timer tick, asking Buildbucket for the build status
[13:25:28.261] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:28.261] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:4:0) after 1m0s
[13:26:28.318] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:4:0)
[13:26:28.318] Timer tick, asking Buildbucket for the build status
[13:26:28.422] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:28.422] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:5:0) after 1m0s
[13:27:28.481] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:5:0)
[13:27:28.481] Timer tick, asking Buildbucket for the build status
[13:27:28.657] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:28.657] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:6:0) after 1m0s
[13:28:28.722] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:6:0)
[13:28:28.722] Timer tick, asking Buildbucket for the build status
[13:28:28.813] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:28.813] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:7:0) after 1m0s
[13:29:28.856] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:7:0)
[13:29:28.856] Timer tick, asking Buildbucket for the build status
[13:29:28.962] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:28.962] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:8:0) after 1m0s
[13:30:29.015] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:8:0)
[13:30:29.015] Timer tick, asking Buildbucket for the build status
[13:30:29.156] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:29.156] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:9:0) after 1m0s
[13:31:29.293] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:9:0)
[13:31:29.293] Timer tick, asking Buildbucket for the build status
[13:31:29.393] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:29.393] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:10:0) after 1m0s
[13:32:29.456] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:10:0)
[13:32:29.456] Timer tick, asking Buildbucket for the build status
[13:32:29.532] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:29.532] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:11:0) after 1m0s
[13:33:29.572] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:11:0)
[13:33:29.572] Timer tick, asking Buildbucket for the build status
[13:33:29.658] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:29.658] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:12:0) after 1m0s
[13:34:29.702] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:12:0)
[13:34:29.702] Timer tick, asking Buildbucket for the build status
[13:34:30.084] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:30.084] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:13:0) after 1m0s
[13:35:30.178] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:13:0)
[13:35:30.178] Timer tick, asking Buildbucket for the build status
[13:35:30.472] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:30.472] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:14:0) after 1m0s
[13:36:30.548] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:14:0)
[13:36:30.548] Timer tick, asking Buildbucket for the build status
[13:36:30.628] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:30.629] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:15:0) after 1m0s
[13:37:30.715] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:15:0)
[13:37:30.715] Timer tick, asking Buildbucket for the build status
[13:37:30.801] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:30.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:16:0) after 1m0s
[13:38:30.911] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:16:0)
[13:38:30.911] Timer tick, asking Buildbucket for the build status
[13:38:30.997] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:30.997] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:17:0) after 1m0s
[13:39:31.062] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:17:0)
[13:39:31.062] Timer tick, asking Buildbucket for the build status
[13:39:31.145] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:31.145] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:18:0) after 1m0s
[13:40:31.262] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:18:0)
[13:40:31.262] Timer tick, asking Buildbucket for the build status
[13:40:31.400] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:31.400] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:19:0) after 1m0s
[13:41:31.487] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:19:0)
[13:41:31.487] Timer tick, asking Buildbucket for the build status
[13:41:31.566] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:31.566] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:20:0) after 1m0s
[13:42:31.622] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:20:0)
[13:42:31.622] Timer tick, asking Buildbucket for the build status
[13:42:31.924] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:31.924] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:21:0) after 1m0s
[13:43:31.980] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:21:0)
[13:43:31.980] Timer tick, asking Buildbucket for the build status
[13:43:32.046] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:32.046] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:22:0) after 1m0s
[13:44:32.144] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:22:0)
[13:44:32.144] Timer tick, asking Buildbucket for the build status
[13:44:32.379] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:32.379] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:23:0) after 1m0s
[13:45:32.421] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:23:0)
[13:45:32.421] Timer tick, asking Buildbucket for the build status
[13:45:32.478] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:32.478] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:24:0) after 1m0s
[13:46:32.537] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:24:0)
[13:46:32.537] Timer tick, asking Buildbucket for the build status
[13:46:32.708] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:32.708] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:25:0) after 1m0s
[13:47:32.748] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:25:0)
[13:47:32.748] Timer tick, asking Buildbucket for the build status
[13:47:32.813] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:32.813] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:26:0) after 1m0s
[13:48:32.987] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:26:0)
[13:48:32.987] Timer tick, asking Buildbucket for the build status
[13:48:33.099] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:33.099] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:27:0) after 1m0s
[13:49:33.332] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:27:0)
[13:49:33.332] Timer tick, asking Buildbucket for the build status
[13:49:33.484] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:33.484] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:28:0) after 1m0s
[13:50:33.591] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:28:0)
[13:50:33.591] Timer tick, asking Buildbucket for the build status
[13:50:33.671] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:33.671] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:29:0) after 1m0s
[13:51:33.749] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:29:0)
[13:51:33.749] Timer tick, asking Buildbucket for the build status
[13:51:34.056] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:34.056] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:30:0) after 1m0s
[13:52:34.121] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:30:0)
[13:52:34.121] Timer tick, asking Buildbucket for the build status
[13:52:34.201] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:34.201] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:31:0) after 1m0s
[13:53:34.295] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:31:0)
[13:53:34.295] Timer tick, asking Buildbucket for the build status
[13:53:34.385] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:34.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:32:0) after 1m0s
[13:54:34.477] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:32:0)
[13:54:34.477] Timer tick, asking Buildbucket for the build status
[13:54:34.681] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:34.681] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:33:0) after 1m0s
[13:55:34.698] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:33:0)
[13:55:34.698] Timer tick, asking Buildbucket for the build status
[13:55:34.865] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:34.865] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:34:0) after 1m0s
[13:56:34.920] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:34:0)
[13:56:34.920] Timer tick, asking Buildbucket for the build status
[13:56:35.001] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:35.001] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:35:0) after 1m0s
[13:57:35.027] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:35:0)
[13:57:35.027] Timer tick, asking Buildbucket for the build status
[13:57:35.103] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:35.103] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:36:0) after 1m0s
[13:58:35.183] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:36:0)
[13:58:35.183] Timer tick, asking Buildbucket for the build status
[13:58:35.988] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:35.988] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:37:0) after 1m0s
[13:59:36.163] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:37:0)
[13:59:36.163] Timer tick, asking Buildbucket for the build status
[13:59:36.328] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:36.328] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:38:0) after 1m0s
[14:00:36.521] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:38:0)
[14:00:36.521] Timer tick, asking Buildbucket for the build status
[14:00:36.592] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:36.592] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:39:0) after 1m0s
[14:01:36.727] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:39:0)
[14:01:36.727] Timer tick, asking Buildbucket for the build status
[14:01:36.829] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:36.829] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:40:0) after 1m0s
[14:02:37.078] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:40:0)
[14:02:37.078] Timer tick, asking Buildbucket for the build status
[14:02:37.325] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:37.325] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:41:0) after 1m0s
[14:03:37.376] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:41:0)
[14:03:37.376] Timer tick, asking Buildbucket for the build status
[14:03:37.591] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:37.591] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:42:0) after 1m0s
[14:04:37.665] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:42:0)
[14:04:37.665] Timer tick, asking Buildbucket for the build status
[14:04:37.989] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:37.989] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:43:0) after 1m0s
[14:05:38.035] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:43:0)
[14:05:38.035] Timer tick, asking Buildbucket for the build status
[14:05:38.101] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:38.101] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:44:0) after 1m0s
[14:06:38.128] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:44:0)
[14:06:38.128] Timer tick, asking Buildbucket for the build status
[14:06:38.239] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:38.239] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:45:0) after 1m0s
[14:07:38.324] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:45:0)
[14:07:38.324] Timer tick, asking Buildbucket for the build status
[14:07:38.405] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:38.405] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:46:0) after 1m0s
[14:08:38.482] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:46:0)
[14:08:38.482] Timer tick, asking Buildbucket for the build status
[14:08:38.592] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:38.592] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:47:0) after 1m0s
[14:09:38.668] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:47:0)
[14:09:38.668] Timer tick, asking Buildbucket for the build status
[14:09:39.028] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:39.028] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:48:0) after 1m0s
[14:10:39.078] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:48:0)
[14:10:39.078] Timer tick, asking Buildbucket for the build status
[14:10:39.170] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:39.170] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:49:0) after 1m0s
[14:11:39.208] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:49:0)
[14:11:39.208] Timer tick, asking Buildbucket for the build status
[14:11:39.305] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:39.305] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:50:0) after 1m0s
[14:12:39.397] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:50:0)
[14:12:39.397] Timer tick, asking Buildbucket for the build status
[14:12:39.466] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:39.466] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:51:0) after 1m0s
[14:13:39.685] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:51:0)
[14:13:39.685] Timer tick, asking Buildbucket for the build status
[14:13:40.444] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:40.444] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:52:0) after 1m0s
[14:14:40.617] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:52:0)
[14:14:40.617] Timer tick, asking Buildbucket for the build status
[14:14:40.813] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:40.813] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:53:0) after 1m0s
[14:15:40.867] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:53:0)
[14:15:40.867] Timer tick, asking Buildbucket for the build status
[14:15:41.042] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:41.042] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:54:0) after 1m0s
[14:16:41.175] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:54:0)
[14:16:41.175] Timer tick, asking Buildbucket for the build status
[14:16:41.245] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:41.245] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:55:0) after 1m0s
[14:17:41.323] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:55:0)
[14:17:41.323] Timer tick, asking Buildbucket for the build status
[14:17:41.422] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:41.423] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:56:0) after 1m0s
[14:18:41.509] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:56:0)
[14:18:41.509] Timer tick, asking Buildbucket for the build status
[14:18:42.245] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:42.245] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:57:0) after 1m0s
[14:19:42.306] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:57:0)
[14:19:42.306] Timer tick, asking Buildbucket for the build status
[14:19:42.428] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:42.428] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:58:0) after 1m0s
[14:20:42.508] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:58:0)
[14:20:42.508] Timer tick, asking Buildbucket for the build status
[14:20:42.564] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:42.564] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:59:0) after 1m0s
[14:21:42.602] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:59:0)
[14:21:42.602] Timer tick, asking Buildbucket for the build status
[14:21:42.661] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:42.661] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:60:0) after 1m0s
[14:22:42.821] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:60:0)
[14:22:42.821] Timer tick, asking Buildbucket for the build status
[14:22:42.909] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:42.909] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:61:0) after 1m0s
[14:23:43.012] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:61:0)
[14:23:43.012] Timer tick, asking Buildbucket for the build status
[14:23:43.125] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:43.125] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:62:0) after 1m0s
[14:24:43.152] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:62:0)
[14:24:43.152] Timer tick, asking Buildbucket for the build status
[14:24:43.365] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:43.365] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:63:0) after 1m0s
[14:25:43.436] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:63:0)
[14:25:43.436] Timer tick, asking Buildbucket for the build status
[14:25:43.526] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:43.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:64:0) after 1m0s
[14:26:43.571] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:64:0)
[14:26:43.571] Timer tick, asking Buildbucket for the build status
[14:26:43.710] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:43.710] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:65:0) after 1m0s
[14:27:43.736] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:65:0)
[14:27:43.736] Timer tick, asking Buildbucket for the build status
[14:27:43.801] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:43.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:66:0) after 1m0s
[14:28:43.920] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:66:0)
[14:28:43.920] Timer tick, asking Buildbucket for the build status
[14:28:44.002] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:44.002] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:67:0) after 1m0s
[14:29:43.983] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:67:0)
[14:29:43.983] Timer tick, asking Buildbucket for the build status
[14:29:44.269] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:44.269] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:68:0) after 1m0s
[14:30:44.365] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:68:0)
[14:30:44.365] Timer tick, asking Buildbucket for the build status
[14:30:44.476] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:44.476] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:69:0) after 1m0s
[14:31:44.524] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:69:0)
[14:31:44.524] Timer tick, asking Buildbucket for the build status
[14:31:44.602] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:44.602] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:70:0) after 1m0s
[14:32:44.610] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:70:0)
[14:32:44.610] Timer tick, asking Buildbucket for the build status
[14:32:44.690] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:44.690] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:71:0) after 1m0s
[14:33:44.749] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:71:0)
[14:33:44.749] Timer tick, asking Buildbucket for the build status
[14:33:44.835] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:44.835] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:72:0) after 1m0s
[14:34:44.952] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:72:0)
[14:34:44.952] Timer tick, asking Buildbucket for the build status
[14:34:45.121] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:45.121] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:73:0) after 1m0s
[14:35:45.191] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:73:0)
[14:35:45.191] Timer tick, asking Buildbucket for the build status
[14:35:45.635] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:45.635] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:74:0) after 1m0s
[14:36:45.668] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:74:0)
[14:36:45.668] Timer tick, asking Buildbucket for the build status
[14:36:45.749] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:45.749] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:75:0) after 1m0s
[14:37:45.775] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:75:0)
[14:37:45.775] Timer tick, asking Buildbucket for the build status
[14:37:45.854] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:45.854] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:76:0) after 1m0s
[14:38:45.885] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:76:0)
[14:38:45.885] Timer tick, asking Buildbucket for the build status
[14:38:47.095] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:47.095] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:77:0) after 1m0s
[14:39:47.241] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:77:0)
[14:39:47.241] Timer tick, asking Buildbucket for the build status
[14:39:47.360] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:47.360] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:78:0) after 1m0s
[14:40:47.383] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:78:0)
[14:40:47.383] Timer tick, asking Buildbucket for the build status
[14:40:47.589] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:47.589] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:79:0) after 1m0s
[14:41:47.651] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:79:0)
[14:41:47.651] Timer tick, asking Buildbucket for the build status
[14:41:47.743] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:47.743] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:80:0) after 1m0s
[14:42:47.786] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:80:0)
[14:42:47.786] Timer tick, asking Buildbucket for the build status
[14:42:48.074] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:48.074] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:81:0) after 1m0s
[14:43:48.111] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:81:0)
[14:43:48.111] Timer tick, asking Buildbucket for the build status
[14:43:48.476] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:48.476] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:82:0) after 1m0s
[14:44:48.553] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:82:0)
[14:44:48.553] Timer tick, asking Buildbucket for the build status
[14:44:48.712] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:48.712] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:83:0) after 1m0s
[14:45:48.739] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:83:0)
[14:45:48.739] Timer tick, asking Buildbucket for the build status
[14:45:48.804] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:48.804] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:84:0) after 1m0s
[14:46:48.879] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:84:0)
[14:46:48.879] Timer tick, asking Buildbucket for the build status
[14:46:48.949] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:48.949] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:85:0) after 1m0s
[14:47:49.132] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:85:0)
[14:47:49.132] Timer tick, asking Buildbucket for the build status
[14:47:49.305] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:49.305] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:86:0) after 1m0s
[14:48:49.392] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:86:0)
[14:48:49.392] Timer tick, asking Buildbucket for the build status
[14:48:50.233] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:50.233] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:87:0) after 1m0s
[14:49:50.333] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:87:0)
[14:49:50.333] Timer tick, asking Buildbucket for the build status
[14:49:50.453] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:50.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:88:0) after 1m0s
[14:50:50.513] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:88:0)
[14:50:50.513] Timer tick, asking Buildbucket for the build status
[14:50:50.707] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:50.707] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:89:0) after 1m0s
[14:51:50.727] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:89:0)
[14:51:50.727] Timer tick, asking Buildbucket for the build status
[14:51:50.818] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:50.818] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:90:0) after 1m0s
[14:52:50.923] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:90:0)
[14:52:50.923] Timer tick, asking Buildbucket for the build status
[14:52:51.026] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:51.026] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:91:0) after 1m0s
[14:53:51.088] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:91:0)
[14:53:51.088] Timer tick, asking Buildbucket for the build status
[14:53:51.190] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:51.191] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:92:0) after 1m0s
[14:54:51.328] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:92:0)
[14:54:51.328] Timer tick, asking Buildbucket for the build status
[14:54:51.453] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:51.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:93:0) after 1m0s
[14:55:51.482] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:93:0)
[14:55:51.482] Timer tick, asking Buildbucket for the build status
[14:55:51.568] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:51.568] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:94:0) after 1m0s
[14:56:51.579] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:94:0)
[14:56:51.579] Timer tick, asking Buildbucket for the build status
[14:56:51.642] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:51.642] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:95:0) after 1m0s
[14:57:51.762] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:95:0)
[14:57:51.762] Timer tick, asking Buildbucket for the build status
[14:57:51.833] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:51.833] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:96:0) after 1m0s
[14:58:51.980] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:96:0)
[14:58:51.980] Timer tick, asking Buildbucket for the build status
[14:58:52.086] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:52.086] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:97:0) after 1m0s
[14:59:52.135] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:97:0)
[14:59:52.135] Timer tick, asking Buildbucket for the build status
[14:59:52.291] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:52.291] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:98:0) after 1m0s
[15:00:52.322] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:98:0)
[15:00:52.322] Timer tick, asking Buildbucket for the build status
[15:00:52.404] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:52.404] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:99:0) after 1m0s
[15:01:52.654] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:99:0)
[15:01:52.654] Timer tick, asking Buildbucket for the build status
[15:01:52.772] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:52.772] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:100:0) after 1m0s
[15:02:53.199] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:100:0)
[15:02:53.199] Timer tick, asking Buildbucket for the build status
[15:02:53.296] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:53.296] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:101:0) after 1m0s
[15:03:53.425] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:101:0)
[15:03:53.425] Timer tick, asking Buildbucket for the build status
[15:03:53.516] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:53.516] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:102:0) after 1m0s
[15:04:53.810] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:102:0)
[15:04:53.810] Timer tick, asking Buildbucket for the build status
[15:04:54.023] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:54.023] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:103:0) after 1m0s
[15:05:54.299] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:103:0)
[15:05:54.299] Timer tick, asking Buildbucket for the build status
[15:05:54.378] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:54.378] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:104:0) after 1m0s
[15:06:54.539] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:104:0)
[15:06:54.539] Timer tick, asking Buildbucket for the build status
[15:06:55.055] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:55.055] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:105:0) after 1m0s
[15:07:59.383] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:105:0)
[15:07:59.383] Timer tick, asking Buildbucket for the build status
[15:07:59.902] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:59.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:106:0) after 1m0s
[15:08:59.933] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:106:0)
[15:08:59.933] Timer tick, asking Buildbucket for the build status
[15:09:00.220] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:00.220] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:107:0) after 1m0s
[15:10:01.239] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:107:0)
[15:10:01.239] Timer tick, asking Buildbucket for the build status
[15:10:01.386] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:01.386] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:108:0) after 1m0s
[15:11:01.385] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:108:0)
[15:11:01.385] Timer tick, asking Buildbucket for the build status
[15:11:01.492] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:01.492] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:109:0) after 1m0s
[15:12:01.858] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:109:0)
[15:12:01.859] Timer tick, asking Buildbucket for the build status
[15:12:02.153] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:02.153] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:110:0) after 1m0s
[15:13:02.268] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:110:0)
[15:13:02.268] Timer tick, asking Buildbucket for the build status
[15:13:02.404] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:02.404] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:111:0) after 1m0s
[15:14:02.473] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:111:0)
[15:14:02.473] Timer tick, asking Buildbucket for the build status
[15:14:03.022] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:03.022] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:112:0) after 1m0s
[15:15:03.099] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:112:0)
[15:15:03.099] Timer tick, asking Buildbucket for the build status
[15:15:03.649] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:03.649] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:113:0) after 1m0s
[15:16:03.782] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:113:0)
[15:16:03.782] Timer tick, asking Buildbucket for the build status
[15:16:03.996] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:03.996] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:114:0) after 1m0s
[15:17:04.140] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:114:0)
[15:17:04.140] Timer tick, asking Buildbucket for the build status
[15:17:04.375] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:04.375] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:115:0) after 1m0s
[15:18:04.495] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:115:0)
[15:18:04.495] Timer tick, asking Buildbucket for the build status
[15:18:04.582] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:04.582] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:116:0) after 1m0s
[15:19:04.755] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:116:0)
[15:19:04.755] Timer tick, asking Buildbucket for the build status
[15:19:05.135] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:05.135] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:117:0) after 1m0s
[15:20:05.159] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:117:0)
[15:20:05.159] Timer tick, asking Buildbucket for the build status
[15:20:05.330] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:05.330] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:118:0) after 1m0s
[15:21:05.614] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:118:0)
[15:21:05.614] Timer tick, asking Buildbucket for the build status
[15:21:05.829] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:05.829] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:119:0) after 1m0s
[15:22:05.872] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:119:0)
[15:22:05.872] Timer tick, asking Buildbucket for the build status
[15:22:06.384] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:06.384] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:120:0) after 1m0s
[15:23:06.430] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:120:0)
[15:23:06.430] Timer tick, asking Buildbucket for the build status
[15:23:06.727] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:06.727] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:121:0) after 1m0s
[15:24:06.725] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:121:0)
[15:24:06.725] Timer tick, asking Buildbucket for the build status
[15:24:06.832] Build 8864104453064878560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:06.832] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9029534515402182288:122:0) after 1m0s
[15:24:14.222] Received PubSub notification, asking Buildbucket for the build status
[15:24:14.384] Build 8864104453064878560: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:24:14.384] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1604935453172475",
"created_by": "project:r8",
"created_ts": "1604928267377557",
"id": "8864104453064878560",
"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\": \"aed5e6c28fb85c82633622bb15bf2e087e64daa1\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@aed5e6c28fb85c82633622bb15bf2e087e64daa1\", \"title\": \"aed5e6c28fb85c82633622bb15bf2e087e64daa1\", \"url\": \"https://r8.googlesource.com/r8/+/aed5e6c28fb85c82633622bb15bf2e087e64daa1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"aed5e6c28fb85c82633622bb15bf2e087e64daa1\"}}",
"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\": \"aed5e6c28fb85c82633622bb15bf2e087e64daa1\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@aed5e6c28fb85c82633622bb15bf2e087e64daa1\", \"title\": \"aed5e6c28fb85c82633622bb15bf2e087e64daa1\", \"url\": \"https://r8.googlesource.com/r8/+/aed5e6c28fb85c82633622bb15bf2e087e64daa1\"}]}, \"bot_id\": \"luci-r8-custom-ci-xenial-9-aw4p\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-jdk8\", \"buildnumber\": 99, \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"aed5e6c28fb85c82633622bb15bf2e087e64daa1\", \"test_options\": [\"--runtimes=jdk8\", \"--no_internal\", \"--one_line_per_test\", \"--archive_failures\"]}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_535ad7637a04c3e27d1496cee679fa117c96e8656eac01642dd379313c9a8210_v2\", \"builder_559b7f17b03f2fb390e5fa1b342f7064ff21d1b422daa1448c6720038444081e_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-9-aw4p\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604928308482367",
"status": "COMPLETED",
"status_changed_ts": "1604935453708040",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/99",
"builder:linux-jdk8",
"buildset:commit/git/aed5e6c28fb85c82633622bb15bf2e087e64daa1",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/aed5e6c28fb85c82633622bb15bf2e087e64daa1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029534515402182288",
"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/8864104453064878560/+/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:4fc5ff725bc8bb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604935453886682",
"url": "https://ci.chromium.org/b/8864104453064878560",
"utcnow_ts": "1604935454366866"
}
}
[15:24:14.384] Invocation finished in 1h59m48.619177692s with status SUCCEEDED