[11:14:45.145] New invocation is queued and will start shortly
[11:14:50.245] Starting the invocation (attempt 1)
[11:14:50.281] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:14:50.281] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:14:50.281] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9024197452988090992",
"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\":\"9f4c39440373db59d669be4c63dfe2e13cd08337\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@9f4c39440373db59d669be4c63dfe2e13cd08337\",\"title\":\"9f4c39440373db59d669be4c63dfe2e13cd08337\",\"url\":\"https://r8.googlesource.com/r8/+/9f4c39440373db59d669be4c63dfe2e13cd08337\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"9f4c39440373db59d669be4c63dfe2e13cd08337\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-jdk8",
"scheduler_invocation_id:9024197452988090992",
"scheduler_job_id:r8/linux-jdk8",
"user_agent:luci-scheduler",
"buildset:commit/git/9f4c39440373db59d669be4c63dfe2e13cd08337",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/9f4c39440373db59d669be4c63dfe2e13cd08337",
"gitiles_ref:refs/heads/master"
]
}
[11:14:52.268] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:r8",
"created_ts": "1610018090385570",
"id": "8858767386814240032",
"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\": \"9f4c39440373db59d669be4c63dfe2e13cd08337\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@9f4c39440373db59d669be4c63dfe2e13cd08337\", \"title\": \"9f4c39440373db59d669be4c63dfe2e13cd08337\", \"url\": \"https://r8.googlesource.com/r8/+/9f4c39440373db59d669be4c63dfe2e13cd08337\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"9f4c39440373db59d669be4c63dfe2e13cd08337\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610018091985254",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/316",
"builder:linux-jdk8",
"buildset:commit/git/9f4c39440373db59d669be4c63dfe2e13cd08337",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/9f4c39440373db59d669be4c63dfe2e13cd08337",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024197452988090992",
"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/8858767386814240032/+/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": "1610018091985367",
"url": "https://ci.chromium.org/b/8858767386814240032",
"utcnow_ts": "1610018092251396"
}
}
[11:14:52.268] Task URL: https://ci.chromium.org/b/8858767386814240032
[11:14:52.268] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:2:0) after 1m0s
[11:15:21.818] Received PubSub notification, asking Buildbucket for the build status
[11:15:21.903] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:52.534] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:2:0)
[11:15:52.534] Timer tick, asking Buildbucket for the build status
[11:15:52.661] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:52.661] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:4:0) after 1m0s
[11:16:52.981] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:4:0)
[11:16:52.981] Timer tick, asking Buildbucket for the build status
[11:16:53.476] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:53.476] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:5:0) after 1m0s
[11:17:53.828] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:5:0)
[11:17:53.828] Timer tick, asking Buildbucket for the build status
[11:17:53.912] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:53.912] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:6:0) after 1m0s
[11:18:54.400] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:6:0)
[11:18:54.400] Timer tick, asking Buildbucket for the build status
[11:18:54.470] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:54.470] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:7:0) after 1m0s
[11:19:54.546] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:7:0)
[11:19:54.546] Timer tick, asking Buildbucket for the build status
[11:19:54.653] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:54.653] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:8:0) after 1m0s
[11:20:54.827] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:8:0)
[11:20:54.827] Timer tick, asking Buildbucket for the build status
[11:20:54.890] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:54.890] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:9:0) after 1m0s
[11:21:54.962] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:9:0)
[11:21:54.962] Timer tick, asking Buildbucket for the build status
[11:21:55.018] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:55.018] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:10:0) after 1m0s
[11:22:55.164] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:10:0)
[11:22:55.164] Timer tick, asking Buildbucket for the build status
[11:22:55.219] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:55.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:11:0) after 1m0s
[11:23:55.267] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:11:0)
[11:23:55.267] Timer tick, asking Buildbucket for the build status
[11:23:55.407] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:55.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:12:0) after 1m0s
[11:24:55.497] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:12:0)
[11:24:55.497] Timer tick, asking Buildbucket for the build status
[11:24:55.595] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:55.595] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:13:0) after 1m0s
[11:25:55.616] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:13:0)
[11:25:55.616] Timer tick, asking Buildbucket for the build status
[11:25:55.669] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:55.669] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:14:0) after 1m0s
[11:26:55.742] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:14:0)
[11:26:55.742] Timer tick, asking Buildbucket for the build status
[11:26:55.854] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:55.854] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:15:0) after 1m0s
[11:27:55.925] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:15:0)
[11:27:55.925] Timer tick, asking Buildbucket for the build status
[11:27:55.973] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:55.973] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:16:0) after 1m0s
[11:28:56.507] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:16:0)
[11:28:56.507] Timer tick, asking Buildbucket for the build status
[11:28:56.577] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:56.577] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:17:0) after 1m0s
[11:29:56.774] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:17:0)
[11:29:56.774] Timer tick, asking Buildbucket for the build status
[11:29:56.898] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:56.898] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:18:0) after 1m0s
[11:30:57.121] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:18:0)
[11:30:57.121] Timer tick, asking Buildbucket for the build status
[11:30:57.498] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:57.498] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:19:0) after 1m0s
[11:31:57.567] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:19:0)
[11:31:57.567] Timer tick, asking Buildbucket for the build status
[11:31:57.656] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:57.656] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:20:0) after 1m0s
[11:32:57.678] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:20:0)
[11:32:57.678] Timer tick, asking Buildbucket for the build status
[11:32:57.808] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:57.808] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:21:0) after 1m0s
[11:33:57.884] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:21:0)
[11:33:57.884] Timer tick, asking Buildbucket for the build status
[11:33:57.999] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:57.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:22:0) after 1m0s
[11:34:58.021] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:22:0)
[11:34:58.021] Timer tick, asking Buildbucket for the build status
[11:34:58.191] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:58.191] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:23:0) after 1m0s
[11:35:58.212] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:23:0)
[11:35:58.212] Timer tick, asking Buildbucket for the build status
[11:35:58.469] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:58.469] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:24:0) after 1m0s
[11:36:58.600] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:24:0)
[11:36:58.600] Timer tick, asking Buildbucket for the build status
[11:36:58.723] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:58.723] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:25:0) after 1m0s
[11:37:58.743] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:25:0)
[11:37:58.743] Timer tick, asking Buildbucket for the build status
[11:37:59.001] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:59.001] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:26:0) after 1m0s
[11:38:59.044] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:26:0)
[11:38:59.044] Timer tick, asking Buildbucket for the build status
[11:38:59.198] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:59.198] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:27:0) after 1m0s
[11:39:59.214] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:27:0)
[11:39:59.214] Timer tick, asking Buildbucket for the build status
[11:39:59.404] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:59.404] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:28:0) after 1m0s
[11:40:59.505] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:28:0)
[11:40:59.505] Timer tick, asking Buildbucket for the build status
[11:40:59.561] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:59.561] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:29:0) after 1m0s
[11:41:59.690] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:29:0)
[11:41:59.690] Timer tick, asking Buildbucket for the build status
[11:41:59.775] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:59.775] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:30:0) after 1m0s
[11:42:59.968] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:30:0)
[11:42:59.968] Timer tick, asking Buildbucket for the build status
[11:43:00.150] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:00.150] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:31:0) after 1m0s
[11:44:00.181] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:31:0)
[11:44:00.181] Timer tick, asking Buildbucket for the build status
[11:44:00.241] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:00.241] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:32:0) after 1m0s
[11:45:00.328] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:32:0)
[11:45:00.328] Timer tick, asking Buildbucket for the build status
[11:45:00.476] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:00.476] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:33:0) after 1m0s
[11:46:00.640] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:33:0)
[11:46:00.640] Timer tick, asking Buildbucket for the build status
[11:46:00.703] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:00.703] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:34:0) after 1m0s
[11:47:01.711] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:34:0)
[11:47:01.711] Timer tick, asking Buildbucket for the build status
[11:47:02.139] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:02.139] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:35:0) after 1m0s
[11:48:02.357] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:35:0)
[11:48:02.357] Timer tick, asking Buildbucket for the build status
[11:48:02.432] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:02.432] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:36:0) after 1m0s
[11:49:02.679] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:36:0)
[11:49:02.680] Timer tick, asking Buildbucket for the build status
[11:49:02.774] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:02.774] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:37:0) after 1m0s
[11:50:02.907] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:37:0)
[11:50:02.907] Timer tick, asking Buildbucket for the build status
[11:50:03.019] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:03.019] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:38:0) after 1m0s
[11:51:03.172] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:38:0)
[11:51:03.172] Timer tick, asking Buildbucket for the build status
[11:51:03.341] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:03.341] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:39:0) after 1m0s
[11:52:03.385] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:39:0)
[11:52:03.385] Timer tick, asking Buildbucket for the build status
[11:52:03.674] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:03.674] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:40:0) after 1m0s
[11:53:03.760] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:40:0)
[11:53:03.760] Timer tick, asking Buildbucket for the build status
[11:53:03.819] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:03.819] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:41:0) after 1m0s
[11:54:03.975] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:41:0)
[11:54:03.975] Timer tick, asking Buildbucket for the build status
[11:54:04.064] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:04.064] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:42:0) after 1m0s
[11:55:04.238] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:42:0)
[11:55:04.238] Timer tick, asking Buildbucket for the build status
[11:55:04.392] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:04.392] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:43:0) after 1m0s
[11:56:04.424] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:43:0)
[11:56:04.424] Timer tick, asking Buildbucket for the build status
[11:56:04.563] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:04.563] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:44:0) after 1m0s
[11:57:04.703] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:44:0)
[11:57:04.703] Timer tick, asking Buildbucket for the build status
[11:57:04.787] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:04.787] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:45:0) after 1m0s
[11:58:04.805] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:45:0)
[11:58:04.805] Timer tick, asking Buildbucket for the build status
[11:58:05.047] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:05.047] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:46:0) after 1m0s
[11:59:05.055] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:46:0)
[11:59:05.055] Timer tick, asking Buildbucket for the build status
[11:59:05.159] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:05.159] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:47:0) after 1m0s
[12:00:05.216] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:47:0)
[12:00:05.216] Timer tick, asking Buildbucket for the build status
[12:00:05.372] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:05.372] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:48:0) after 1m0s
[12:01:05.742] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:48:0)
[12:01:05.742] Timer tick, asking Buildbucket for the build status
[12:01:05.809] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:05.809] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:49:0) after 1m0s
[12:02:06.096] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:49:0)
[12:02:06.096] Timer tick, asking Buildbucket for the build status
[12:02:06.178] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:06.178] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:50:0) after 1m0s
[12:03:06.388] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:50:0)
[12:03:06.388] Timer tick, asking Buildbucket for the build status
[12:03:06.447] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:06.447] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:51:0) after 1m0s
[12:04:06.504] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:51:0)
[12:04:06.504] Timer tick, asking Buildbucket for the build status
[12:04:06.710] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:06.710] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:52:0) after 1m0s
[12:05:06.842] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:52:0)
[12:05:06.842] Timer tick, asking Buildbucket for the build status
[12:05:06.997] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:06.997] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:53:0) after 1m0s
[12:06:07.086] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:53:0)
[12:06:07.086] Timer tick, asking Buildbucket for the build status
[12:06:07.254] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:07.254] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:54:0) after 1m0s
[12:07:07.246] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:54:0)
[12:07:07.246] Timer tick, asking Buildbucket for the build status
[12:07:07.348] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:07.348] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:55:0) after 1m0s
[12:08:07.398] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:55:0)
[12:08:07.398] Timer tick, asking Buildbucket for the build status
[12:08:07.478] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:07.478] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:56:0) after 1m0s
[12:09:07.486] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:56:0)
[12:09:07.486] Timer tick, asking Buildbucket for the build status
[12:09:07.567] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:07.567] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:57:0) after 1m0s
[12:10:07.662] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:57:0)
[12:10:07.662] Timer tick, asking Buildbucket for the build status
[12:10:08.222] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:08.222] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:58:0) after 1m0s
[12:11:08.431] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:58:0)
[12:11:08.431] Timer tick, asking Buildbucket for the build status
[12:11:08.503] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:08.504] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:59:0) after 1m0s
[12:12:08.660] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:59:0)
[12:12:08.660] Timer tick, asking Buildbucket for the build status
[12:12:08.760] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:08.760] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:60:0) after 1m0s
[12:13:08.917] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:60:0)
[12:13:08.917] Timer tick, asking Buildbucket for the build status
[12:13:09.103] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:09.103] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:61:0) after 1m0s
[12:14:09.201] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:61:0)
[12:14:09.201] Timer tick, asking Buildbucket for the build status
[12:14:09.417] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:09.417] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:62:0) after 1m0s
[12:15:09.462] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:62:0)
[12:15:09.462] Timer tick, asking Buildbucket for the build status
[12:15:09.862] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:09.862] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:63:0) after 1m0s
[12:16:09.915] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:63:0)
[12:16:09.915] Timer tick, asking Buildbucket for the build status
[12:16:10.119] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:10.119] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:64:0) after 1m0s
[12:17:10.166] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:64:0)
[12:17:10.166] Timer tick, asking Buildbucket for the build status
[12:17:10.523] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:10.523] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:65:0) after 1m0s
[12:18:10.539] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:65:0)
[12:18:10.539] Timer tick, asking Buildbucket for the build status
[12:18:10.651] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:10.652] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:66:0) after 1m0s
[12:19:10.651] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:66:0)
[12:19:10.651] Timer tick, asking Buildbucket for the build status
[12:19:10.983] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:10.983] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:67:0) after 1m0s
[12:20:11.006] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:67:0)
[12:20:11.006] Timer tick, asking Buildbucket for the build status
[12:20:11.147] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:11.147] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:68:0) after 1m0s
[12:21:11.207] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:68:0)
[12:21:11.207] Timer tick, asking Buildbucket for the build status
[12:21:11.526] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:11.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:69:0) after 1m0s
[12:22:11.681] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:69:0)
[12:22:11.681] Timer tick, asking Buildbucket for the build status
[12:22:11.774] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:11.774] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:70:0) after 1m0s
[12:23:11.846] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:70:0)
[12:23:11.846] Timer tick, asking Buildbucket for the build status
[12:23:11.947] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:11.947] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:71:0) after 1m0s
[12:24:12.016] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:71:0)
[12:24:12.016] Timer tick, asking Buildbucket for the build status
[12:24:12.111] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:12.111] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:72:0) after 1m0s
[12:25:12.177] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:72:0)
[12:25:12.177] Timer tick, asking Buildbucket for the build status
[12:25:12.502] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:12.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:73:0) after 1m0s
[12:26:12.562] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:73:0)
[12:26:12.562] Timer tick, asking Buildbucket for the build status
[12:26:12.657] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:12.657] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:74:0) after 1m0s
[12:27:12.727] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:74:0)
[12:27:12.727] Timer tick, asking Buildbucket for the build status
[12:27:12.847] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:12.847] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:75:0) after 1m0s
[12:28:12.883] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:75:0)
[12:28:12.883] Timer tick, asking Buildbucket for the build status
[12:28:13.016] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:13.016] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:76:0) after 1m0s
[12:29:13.042] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:76:0)
[12:29:13.042] Timer tick, asking Buildbucket for the build status
[12:29:13.213] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:13.213] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:77:0) after 1m0s
[12:30:13.312] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:77:0)
[12:30:13.312] Timer tick, asking Buildbucket for the build status
[12:30:13.448] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:13.448] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:78:0) after 1m0s
[12:31:13.547] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:78:0)
[12:31:13.547] Timer tick, asking Buildbucket for the build status
[12:31:13.644] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:13.644] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:79:0) after 1m0s
[12:32:13.717] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:79:0)
[12:32:13.717] Timer tick, asking Buildbucket for the build status
[12:32:13.828] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:13.828] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:80:0) after 1m0s
[12:33:13.917] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:80:0)
[12:33:13.917] Timer tick, asking Buildbucket for the build status
[12:33:14.057] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:14.057] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:81:0) after 1m0s
[12:34:14.172] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:81:0)
[12:34:14.172] Timer tick, asking Buildbucket for the build status
[12:34:14.249] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:14.249] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:82:0) after 1m0s
[12:35:14.260] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:82:0)
[12:35:14.260] Timer tick, asking Buildbucket for the build status
[12:35:14.390] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:14.390] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:83:0) after 1m0s
[12:36:14.448] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:83:0)
[12:36:14.448] Timer tick, asking Buildbucket for the build status
[12:36:14.529] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:14.529] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:84:0) after 1m0s
[12:37:14.596] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:84:0)
[12:37:14.596] Timer tick, asking Buildbucket for the build status
[12:37:14.706] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:14.706] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:85:0) after 1m0s
[12:38:14.741] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:85:0)
[12:38:14.741] Timer tick, asking Buildbucket for the build status
[12:38:14.895] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:14.895] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:86:0) after 1m0s
[12:39:14.994] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:86:0)
[12:39:14.995] Timer tick, asking Buildbucket for the build status
[12:39:15.200] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:15.200] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:87:0) after 1m0s
[12:40:15.355] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:87:0)
[12:40:15.355] Timer tick, asking Buildbucket for the build status
[12:40:15.610] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:15.610] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:88:0) after 1m0s
[12:41:15.704] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:88:0)
[12:41:15.704] Timer tick, asking Buildbucket for the build status
[12:41:15.798] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:15.798] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:89:0) after 1m0s
[12:42:16.345] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:89:0)
[12:42:16.345] Timer tick, asking Buildbucket for the build status
[12:42:16.436] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:16.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:90:0) after 1m0s
[12:43:16.793] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:90:0)
[12:43:16.793] Timer tick, asking Buildbucket for the build status
[12:43:16.855] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:16.855] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:91:0) after 1m0s
[12:44:17.065] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:91:0)
[12:44:17.065] Timer tick, asking Buildbucket for the build status
[12:44:17.141] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:17.141] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:92:0) after 1m0s
[12:45:17.392] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:92:0)
[12:45:17.392] Timer tick, asking Buildbucket for the build status
[12:45:17.528] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:17.528] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:93:0) after 1m0s
[12:46:17.623] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:93:0)
[12:46:17.623] Timer tick, asking Buildbucket for the build status
[12:46:17.836] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:17.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:94:0) after 1m0s
[12:47:17.832] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:94:0)
[12:47:17.832] Timer tick, asking Buildbucket for the build status
[12:47:18.059] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:18.059] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:95:0) after 1m0s
[12:48:18.150] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:95:0)
[12:48:18.150] Timer tick, asking Buildbucket for the build status
[12:48:18.204] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:18.204] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:96:0) after 1m0s
[12:49:18.215] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:96:0)
[12:49:18.215] Timer tick, asking Buildbucket for the build status
[12:49:18.297] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:18.297] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:97:0) after 1m0s
[12:50:18.320] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:97:0)
[12:50:18.320] Timer tick, asking Buildbucket for the build status
[12:50:18.436] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:18.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:98:0) after 1m0s
[12:51:18.467] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:98:0)
[12:51:18.467] Timer tick, asking Buildbucket for the build status
[12:51:18.533] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:18.533] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:99:0) after 1m0s
[12:52:18.555] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:99:0)
[12:52:18.555] Timer tick, asking Buildbucket for the build status
[12:52:18.621] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:18.621] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:100:0) after 1m0s
[12:53:18.635] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:100:0)
[12:53:18.635] Timer tick, asking Buildbucket for the build status
[12:53:18.713] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:18.713] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:101:0) after 1m0s
[12:54:18.812] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:101:0)
[12:54:18.812] Timer tick, asking Buildbucket for the build status
[12:54:18.892] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:18.892] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:102:0) after 1m0s
[12:55:18.996] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:102:0)
[12:55:18.996] Timer tick, asking Buildbucket for the build status
[12:55:19.100] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:19.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:103:0) after 1m0s
[12:56:19.192] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:103:0)
[12:56:19.192] Timer tick, asking Buildbucket for the build status
[12:56:19.483] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:19.483] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:104:0) after 1m0s
[12:57:19.547] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:104:0)
[12:57:19.547] Timer tick, asking Buildbucket for the build status
[12:57:19.777] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:19.777] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:105:0) after 1m0s
[12:58:19.848] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:105:0)
[12:58:19.848] Timer tick, asking Buildbucket for the build status
[12:58:19.944] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:19.944] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:106:0) after 1m0s
[12:59:19.998] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:106:0)
[12:59:19.998] Timer tick, asking Buildbucket for the build status
[12:59:20.063] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:20.063] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:107:0) after 1m0s
[13:00:20.130] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:107:0)
[13:00:20.130] Timer tick, asking Buildbucket for the build status
[13:00:21.222] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:21.222] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:108:0) after 1m0s
[13:01:21.355] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:108:0)
[13:01:21.355] Timer tick, asking Buildbucket for the build status
[13:01:21.878] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:21.878] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:109:0) after 1m0s
[13:02:21.938] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:109:0)
[13:02:21.938] Timer tick, asking Buildbucket for the build status
[13:02:22.017] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:22.017] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:110:0) after 1m0s
[13:03:22.300] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:110:0)
[13:03:22.300] Timer tick, asking Buildbucket for the build status
[13:03:22.375] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:22.375] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:111:0) after 1m0s
[13:04:22.601] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:111:0)
[13:04:22.601] Timer tick, asking Buildbucket for the build status
[13:04:22.716] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:22.716] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:112:0) after 1m0s
[13:05:22.921] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:112:0)
[13:05:22.921] Timer tick, asking Buildbucket for the build status
[13:05:23.078] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:23.078] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:113:0) after 1m0s
[13:06:23.279] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:113:0)
[13:06:23.279] Timer tick, asking Buildbucket for the build status
[13:06:23.486] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:23.486] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:114:0) after 1m0s
[13:07:23.674] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:114:0)
[13:07:23.674] Timer tick, asking Buildbucket for the build status
[13:07:23.793] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:23.793] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:115:0) after 1m0s
[13:08:23.965] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:115:0)
[13:08:23.965] Timer tick, asking Buildbucket for the build status
[13:08:24.077] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:24.077] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:116:0) after 1m0s
[13:09:24.247] Handling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:116:0)
[13:09:24.247] Timer tick, asking Buildbucket for the build status
[13:09:24.404] Build 8858767386814240032: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:24.404] Scheduling timer "check-buildbucket-build-status" (r8/linux-jdk8:9024197452988090992:117:0) after 1m0s
[13:10:11.246] Received PubSub notification, asking Buildbucket for the build status
[13:10:11.574] Build 8858767386814240032: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:10:11.574] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1610025010365333",
"created_by": "project:r8",
"created_ts": "1610018090385570",
"failure_reason": "BUILD_FAILURE",
"id": "8858767386814240032",
"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\": \"9f4c39440373db59d669be4c63dfe2e13cd08337\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@9f4c39440373db59d669be4c63dfe2e13cd08337\", \"title\": \"9f4c39440373db59d669be4c63dfe2e13cd08337\", \"url\": \"https://r8.googlesource.com/r8/+/9f4c39440373db59d669be4c63dfe2e13cd08337\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"9f4c39440373db59d669be4c63dfe2e13cd08337\"}}",
"project": "r8",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('Run tests') (retcode: 1)\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"9f4c39440373db59d669be4c63dfe2e13cd08337\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@9f4c39440373db59d669be4c63dfe2e13cd08337\", \"title\": \"9f4c39440373db59d669be4c63dfe2e13cd08337\", \"url\": \"https://r8.googlesource.com/r8/+/9f4c39440373db59d669be4c63dfe2e13cd08337\"}]}, \"bot_id\": \"luci-r8-custom-ci-xenial-3-stli\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-jdk8\", \"buildnumber\": 316, \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"9f4c39440373db59d669be4c63dfe2e13cd08337\", \"test_options\": [\"--runtimes=jdk8\", \"--no_internal\", \"--one_line_per_test\", \"--archive_failures\"]}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_535ad7637a04c3e27d1496cee679fa117c96e8656eac01642dd379313c9a8210_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"r8bot-265908\"], \"gpu\": [\"none\"], \"id\": [\"luci-r8-custom-ci-xenial-3-stli\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"normal\": [\"true\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.r8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}, \"ui\": {\"info\": \"Step('Run tests') (retcode: 1)\"}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610018111492865",
"status": "COMPLETED",
"status_changed_ts": "1610018121492175",
"tags": [
"build_address:luci.r8.ci/linux-jdk8/316",
"builder:linux-jdk8",
"buildset:commit/git/9f4c39440373db59d669be4c63dfe2e13cd08337",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/9f4c39440373db59d669be4c63dfe2e13cd08337",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024197452988090992",
"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/8858767386814240032/+/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:50f55ffd03ee5c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610025010470618",
"url": "https://ci.chromium.org/b/8858767386814240032",
"utcnow_ts": "1610025011496830"
}
}
[13:10:11.574] Invocation finished in 1h55m26.459485919s with status FAILED