[12:48:53.341] New invocation is queued and will start shortly
[12:48:54.654] Starting the invocation (attempt 1)
[12:48:54.719] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:48:54.719] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:48:54.720] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9035697345178819888",
"parameters_json": "{\"builder_name\":\"linux-internal\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"c21263224469be5b35c4591375fe0180c38073d4\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@c21263224469be5b35c4591375fe0180c38073d4\",\"title\":\"c21263224469be5b35c4591375fe0180c38073d4\",\"url\":\"https://r8.googlesource.com/r8/+/c21263224469be5b35c4591375fe0180c38073d4\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"265e18fda96020afb1fbb2903e96324992f8a27b\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@265e18fda96020afb1fbb2903e96324992f8a27b\",\"title\":\"265e18fda96020afb1fbb2903e96324992f8a27b\",\"url\":\"https://r8.googlesource.com/r8/+/265e18fda96020afb1fbb2903e96324992f8a27b\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"87c903d1d88b581d8935c3c017666db996598a28\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@87c903d1d88b581d8935c3c017666db996598a28\",\"title\":\"87c903d1d88b581d8935c3c017666db996598a28\",\"url\":\"https://r8.googlesource.com/r8/+/87c903d1d88b581d8935c3c017666db996598a28\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"4c6808ac1d139829417e2218881f9ff9c3b7d650\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@4c6808ac1d139829417e2218881f9ff9c3b7d650\",\"title\":\"4c6808ac1d139829417e2218881f9ff9c3b7d650\",\"url\":\"https://r8.googlesource.com/r8/+/4c6808ac1d139829417e2218881f9ff9c3b7d650\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"1a23cf1a2a55e9ac104c7cb3e8503420937155d6\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@1a23cf1a2a55e9ac104c7cb3e8503420937155d6\",\"title\":\"1a23cf1a2a55e9ac104c7cb3e8503420937155d6\",\"url\":\"https://r8.googlesource.com/r8/+/1a23cf1a2a55e9ac104c7cb3e8503420937155d6\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://r8.googlesource.com/r8\",\"revision\":\"65edb6f1caa1fc76bbb292f6827427e9a4f81110\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@65edb6f1caa1fc76bbb292f6827427e9a4f81110\",\"title\":\"65edb6f1caa1fc76bbb292f6827427e9a4f81110\",\"url\":\"https://r8.googlesource.com/r8/+/65edb6f1caa1fc76bbb292f6827427e9a4f81110\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"65edb6f1caa1fc76bbb292f6827427e9a4f81110\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-internal",
"scheduler_invocation_id:9035697345178819888",
"scheduler_job_id:r8/linux-internal",
"user_agent:luci-scheduler",
"buildset:commit/git/65edb6f1caa1fc76bbb292f6827427e9a4f81110",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/65edb6f1caa1fc76bbb292f6827427e9a4f81110",
"gitiles_ref:refs/heads/master"
]
}
[12:48:56.875] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1599050934883886",
"id": "8870267282861864672",
"parameters_json": "{\"builder_name\": \"linux-internal\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"c21263224469be5b35c4591375fe0180c38073d4\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@c21263224469be5b35c4591375fe0180c38073d4\", \"title\": \"c21263224469be5b35c4591375fe0180c38073d4\", \"url\": \"https://r8.googlesource.com/r8/+/c21263224469be5b35c4591375fe0180c38073d4\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"265e18fda96020afb1fbb2903e96324992f8a27b\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@265e18fda96020afb1fbb2903e96324992f8a27b\", \"title\": \"265e18fda96020afb1fbb2903e96324992f8a27b\", \"url\": \"https://r8.googlesource.com/r8/+/265e18fda96020afb1fbb2903e96324992f8a27b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"87c903d1d88b581d8935c3c017666db996598a28\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@87c903d1d88b581d8935c3c017666db996598a28\", \"title\": \"87c903d1d88b581d8935c3c017666db996598a28\", \"url\": \"https://r8.googlesource.com/r8/+/87c903d1d88b581d8935c3c017666db996598a28\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"4c6808ac1d139829417e2218881f9ff9c3b7d650\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@4c6808ac1d139829417e2218881f9ff9c3b7d650\", \"title\": \"4c6808ac1d139829417e2218881f9ff9c3b7d650\", \"url\": \"https://r8.googlesource.com/r8/+/4c6808ac1d139829417e2218881f9ff9c3b7d650\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"1a23cf1a2a55e9ac104c7cb3e8503420937155d6\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@1a23cf1a2a55e9ac104c7cb3e8503420937155d6\", \"title\": \"1a23cf1a2a55e9ac104c7cb3e8503420937155d6\", \"url\": \"https://r8.googlesource.com/r8/+/1a23cf1a2a55e9ac104c7cb3e8503420937155d6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"65edb6f1caa1fc76bbb292f6827427e9a4f81110\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@65edb6f1caa1fc76bbb292f6827427e9a4f81110\", \"title\": \"65edb6f1caa1fc76bbb292f6827427e9a4f81110\", \"url\": \"https://r8.googlesource.com/r8/+/65edb6f1caa1fc76bbb292f6827427e9a4f81110\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"65edb6f1caa1fc76bbb292f6827427e9a4f81110\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599050936492879",
"tags": [
"build_address:luci.r8.ci/linux-internal/1279",
"builder:linux-internal",
"buildset:commit/git/65edb6f1caa1fc76bbb292f6827427e9a4f81110",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/65edb6f1caa1fc76bbb292f6827427e9a4f81110",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035697345178819888",
"scheduler_job_id:r8/linux-internal",
"swarming_hostname:chrome-swarming.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/r8/buildbucket/cr-buildbucket.appspot.com/8870267282861864672/+/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": "1599050936493000",
"url": "https://ci.chromium.org/b/8870267282861864672",
"utcnow_ts": "1599050936818590"
}
}
[12:48:56.875] Task URL: https://ci.chromium.org/b/8870267282861864672
[12:48:56.875] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:2:0) after 1m0s
[12:49:40.532] Received PubSub notification, asking Buildbucket for the build status
[12:49:40.679] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:57.175] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:2:0)
[12:49:57.175] Timer tick, asking Buildbucket for the build status
[12:49:57.327] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:57.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:4:0) after 1m0s
[12:50:57.385] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:4:0)
[12:50:57.385] Timer tick, asking Buildbucket for the build status
[12:50:57.504] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:57.504] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:5:0) after 1m0s
[12:51:57.553] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:5:0)
[12:51:57.553] Timer tick, asking Buildbucket for the build status
[12:51:57.716] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:57.716] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:6:0) after 1m0s
[12:52:57.989] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:6:0)
[12:52:57.989] Timer tick, asking Buildbucket for the build status
[12:52:58.290] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:58.290] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:7:0) after 1m0s
[12:53:58.761] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:7:0)
[12:53:58.761] Timer tick, asking Buildbucket for the build status
[12:53:59.285] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:59.285] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:8:0) after 1m0s
[12:54:59.312] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:8:0)
[12:54:59.312] Timer tick, asking Buildbucket for the build status
[12:54:59.398] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:59.398] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:9:0) after 1m0s
[12:55:59.450] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:9:0)
[12:55:59.450] Timer tick, asking Buildbucket for the build status
[12:55:59.549] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:59.549] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:10:0) after 1m0s
[12:56:59.644] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:10:0)
[12:56:59.644] Timer tick, asking Buildbucket for the build status
[12:56:59.738] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:59.738] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:11:0) after 1m0s
[12:57:59.873] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:11:0)
[12:57:59.873] Timer tick, asking Buildbucket for the build status
[12:58:00.167] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:00.167] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:12:0) after 1m0s
[12:59:00.912] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:12:0)
[12:59:00.912] Timer tick, asking Buildbucket for the build status
[12:59:01.062] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:01.062] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:13:0) after 1m0s
[13:00:01.756] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:13:0)
[13:00:01.756] Timer tick, asking Buildbucket for the build status
[13:00:01.842] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:01.842] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:14:0) after 1m0s
[13:01:02.494] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:14:0)
[13:01:02.494] Timer tick, asking Buildbucket for the build status
[13:01:02.609] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:02.609] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:15:0) after 1m0s
[13:02:03.163] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:15:0)
[13:02:03.163] Timer tick, asking Buildbucket for the build status
[13:02:03.509] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:03.509] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:16:0) after 1m0s
[13:03:03.492] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:16:0)
[13:03:03.492] Timer tick, asking Buildbucket for the build status
[13:03:03.620] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:03.620] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:17:0) after 1m0s
[13:04:03.662] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:17:0)
[13:04:03.662] Timer tick, asking Buildbucket for the build status
[13:04:03.926] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:03.926] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:18:0) after 1m0s
[13:05:03.947] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:18:0)
[13:05:03.947] Timer tick, asking Buildbucket for the build status
[13:05:07.489] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:07.489] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:19:0) after 1m0s
[13:06:07.466] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:19:0)
[13:06:07.466] Timer tick, asking Buildbucket for the build status
[13:06:07.553] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:07.553] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:20:0) after 1m0s
[13:07:07.952] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:20:0)
[13:07:07.952] Timer tick, asking Buildbucket for the build status
[13:07:08.077] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:08.077] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:21:0) after 1m0s
[13:08:08.164] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:21:0)
[13:08:08.164] Timer tick, asking Buildbucket for the build status
[13:08:08.284] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:08.284] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:22:0) after 1m0s
[13:09:08.516] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:22:0)
[13:09:08.516] Timer tick, asking Buildbucket for the build status
[13:09:08.741] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:08.741] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:23:0) after 1m0s
[13:10:08.775] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:23:0)
[13:10:08.775] Timer tick, asking Buildbucket for the build status
[13:10:08.877] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:08.877] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:24:0) after 1m0s
[13:11:08.904] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:24:0)
[13:11:08.904] Timer tick, asking Buildbucket for the build status
[13:11:08.992] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:08.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:25:0) after 1m0s
[13:12:09.078] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:25:0)
[13:12:09.078] Timer tick, asking Buildbucket for the build status
[13:12:09.567] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:09.567] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:26:0) after 1m0s
[13:13:09.599] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:26:0)
[13:13:09.599] Timer tick, asking Buildbucket for the build status
[13:13:09.706] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:09.706] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:27:0) after 1m0s
[13:14:09.714] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:27:0)
[13:14:09.714] Timer tick, asking Buildbucket for the build status
[13:14:09.881] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:09.881] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:28:0) after 1m0s
[13:15:10.221] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:28:0)
[13:15:10.221] Timer tick, asking Buildbucket for the build status
[13:15:10.363] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:10.363] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:29:0) after 1m0s
[13:16:10.618] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:29:0)
[13:16:10.618] Timer tick, asking Buildbucket for the build status
[13:16:10.746] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:10.746] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:30:0) after 1m0s
[13:17:10.800] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:30:0)
[13:17:10.800] Timer tick, asking Buildbucket for the build status
[13:17:10.902] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:10.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:31:0) after 1m0s
[13:18:11.223] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:31:0)
[13:18:11.223] Timer tick, asking Buildbucket for the build status
[13:18:11.481] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:11.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:32:0) after 1m0s
[13:19:11.555] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:32:0)
[13:19:11.555] Timer tick, asking Buildbucket for the build status
[13:19:12.289] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:12.289] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:33:0) after 1m0s
[13:20:12.320] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:33:0)
[13:20:12.320] Timer tick, asking Buildbucket for the build status
[13:20:13.422] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:13.422] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:34:0) after 1m0s
[13:21:13.440] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:34:0)
[13:21:13.440] Timer tick, asking Buildbucket for the build status
[13:21:13.527] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:13.527] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:35:0) after 1m0s
[13:22:13.556] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:35:0)
[13:22:13.556] Timer tick, asking Buildbucket for the build status
[13:22:13.860] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:13.860] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:36:0) after 1m0s
[13:23:13.960] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:36:0)
[13:23:13.960] Timer tick, asking Buildbucket for the build status
[13:23:14.209] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:14.209] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:37:0) after 1m0s
[13:24:14.336] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:37:0)
[13:24:14.336] Timer tick, asking Buildbucket for the build status
[13:24:14.531] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:14.531] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:38:0) after 1m0s
[13:25:14.581] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:38:0)
[13:25:14.581] Timer tick, asking Buildbucket for the build status
[13:25:14.676] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:14.676] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:39:0) after 1m0s
[13:26:14.770] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:39:0)
[13:26:14.770] Timer tick, asking Buildbucket for the build status
[13:26:14.889] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:14.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:40:0) after 1m0s
[13:27:14.971] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:40:0)
[13:27:14.971] Timer tick, asking Buildbucket for the build status
[13:27:15.134] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:15.134] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:41:0) after 1m0s
[13:28:15.225] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:41:0)
[13:28:15.225] Timer tick, asking Buildbucket for the build status
[13:28:15.366] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:15.366] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:42:0) after 1m0s
[13:29:15.419] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:42:0)
[13:29:15.419] Timer tick, asking Buildbucket for the build status
[13:29:15.558] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:15.558] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:43:0) after 1m0s
[13:30:15.747] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:43:0)
[13:30:15.747] Timer tick, asking Buildbucket for the build status
[13:30:15.906] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:15.906] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:44:0) after 1m0s
[13:31:15.950] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:44:0)
[13:31:15.950] Timer tick, asking Buildbucket for the build status
[13:31:16.149] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:16.149] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:45:0) after 1m0s
[13:32:16.179] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:45:0)
[13:32:16.179] Timer tick, asking Buildbucket for the build status
[13:32:16.335] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:16.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:46:0) after 1m0s
[13:33:16.477] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:46:0)
[13:33:16.477] Timer tick, asking Buildbucket for the build status
[13:33:16.643] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:16.643] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:47:0) after 1m0s
[13:34:16.755] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:47:0)
[13:34:16.755] Timer tick, asking Buildbucket for the build status
[13:34:16.911] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:16.911] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:48:0) after 1m0s
[13:35:17.065] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:48:0)
[13:35:17.065] Timer tick, asking Buildbucket for the build status
[13:35:17.170] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:17.171] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:49:0) after 1m0s
[13:36:17.488] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:49:0)
[13:36:17.488] Timer tick, asking Buildbucket for the build status
[13:36:17.642] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:17.642] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:50:0) after 1m0s
[13:37:18.345] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:50:0)
[13:37:18.345] Timer tick, asking Buildbucket for the build status
[13:37:18.448] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:18.448] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:51:0) after 1m0s
[13:38:18.686] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:51:0)
[13:38:18.686] Timer tick, asking Buildbucket for the build status
[13:38:18.776] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:18.776] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:52:0) after 1m0s
[13:39:18.839] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:52:0)
[13:39:18.839] Timer tick, asking Buildbucket for the build status
[13:39:18.994] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:18.994] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:53:0) after 1m0s
[13:40:19.150] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:53:0)
[13:40:19.150] Timer tick, asking Buildbucket for the build status
[13:40:19.266] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:19.266] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:54:0) after 1m0s
[13:41:19.452] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:54:0)
[13:41:19.452] Timer tick, asking Buildbucket for the build status
[13:41:19.570] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:19.570] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:55:0) after 1m0s
[13:42:20.039] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:55:0)
[13:42:20.039] Timer tick, asking Buildbucket for the build status
[13:42:21.653] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:21.653] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:56:0) after 1m0s
[13:43:21.926] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:56:0)
[13:43:21.926] Timer tick, asking Buildbucket for the build status
[13:43:22.056] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:22.056] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:57:0) after 1m0s
[13:44:22.366] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:57:0)
[13:44:22.366] Timer tick, asking Buildbucket for the build status
[13:44:22.641] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:22.643] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:58:0) after 1m0s
[13:45:22.769] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:58:0)
[13:45:22.769] Timer tick, asking Buildbucket for the build status
[13:45:22.873] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:22.873] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:59:0) after 1m0s
[13:46:23.102] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:59:0)
[13:46:23.102] Timer tick, asking Buildbucket for the build status
[13:46:23.446] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:23.446] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:60:0) after 1m0s
[13:47:23.619] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:60:0)
[13:47:23.619] Timer tick, asking Buildbucket for the build status
[13:47:23.756] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:23.756] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:61:0) after 1m0s
[13:48:24.312] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:61:0)
[13:48:24.312] Timer tick, asking Buildbucket for the build status
[13:48:24.749] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:24.753] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:62:0) after 1m0s
[13:49:24.816] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:62:0)
[13:49:24.816] Timer tick, asking Buildbucket for the build status
[13:49:24.976] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:24.976] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:63:0) after 1m0s
[13:50:25.071] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:63:0)
[13:50:25.071] Timer tick, asking Buildbucket for the build status
[13:50:25.177] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:25.177] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:64:0) after 1m0s
[13:51:25.295] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:64:0)
[13:51:25.295] Timer tick, asking Buildbucket for the build status
[13:51:25.406] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:25.406] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:65:0) after 1m0s
[13:52:25.912] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:65:0)
[13:52:25.912] Timer tick, asking Buildbucket for the build status
[13:52:26.087] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:26.088] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:66:0) after 1m0s
[13:53:26.376] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:66:0)
[13:53:26.376] Timer tick, asking Buildbucket for the build status
[13:53:27.246] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:27.246] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:67:0) after 1m0s
[13:54:27.272] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:67:0)
[13:54:27.272] Timer tick, asking Buildbucket for the build status
[13:54:27.600] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:27.600] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:68:0) after 1m0s
[13:55:27.694] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:68:0)
[13:55:27.694] Timer tick, asking Buildbucket for the build status
[13:55:27.808] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:27.808] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:69:0) after 1m0s
[13:56:27.982] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:69:0)
[13:56:27.982] Timer tick, asking Buildbucket for the build status
[13:56:28.067] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:28.067] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:70:0) after 1m0s
[13:57:28.223] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:70:0)
[13:57:28.223] Timer tick, asking Buildbucket for the build status
[13:57:28.311] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:28.311] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:71:0) after 1m0s
[13:58:28.428] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:71:0)
[13:58:28.428] Timer tick, asking Buildbucket for the build status
[13:58:28.560] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:28.560] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:72:0) after 1m0s
[13:59:28.659] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:72:0)
[13:59:28.659] Timer tick, asking Buildbucket for the build status
[13:59:29.172] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:29.172] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:73:0) after 1m0s
[14:00:29.228] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:73:0)
[14:00:29.228] Timer tick, asking Buildbucket for the build status
[14:00:29.356] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:29.356] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:74:0) after 1m0s
[14:01:29.378] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:74:0)
[14:01:29.378] Timer tick, asking Buildbucket for the build status
[14:01:29.819] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:29.819] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:75:0) after 1m0s
[14:02:29.919] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:75:0)
[14:02:29.919] Timer tick, asking Buildbucket for the build status
[14:02:30.037] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:30.037] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:76:0) after 1m0s
[14:03:30.027] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:76:0)
[14:03:30.027] Timer tick, asking Buildbucket for the build status
[14:03:30.409] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:30.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:77:0) after 1m0s
[14:04:30.530] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:77:0)
[14:04:30.530] Timer tick, asking Buildbucket for the build status
[14:04:30.683] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:30.683] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:78:0) after 1m0s
[14:05:30.755] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:78:0)
[14:05:30.755] Timer tick, asking Buildbucket for the build status
[14:05:30.876] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:30.876] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:79:0) after 1m0s
[14:06:31.067] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:79:0)
[14:06:31.067] Timer tick, asking Buildbucket for the build status
[14:06:31.186] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:31.186] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:80:0) after 1m0s
[14:07:31.543] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:80:0)
[14:07:31.543] Timer tick, asking Buildbucket for the build status
[14:07:31.639] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:31.639] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:81:0) after 1m0s
[14:08:31.740] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:81:0)
[14:08:31.740] Timer tick, asking Buildbucket for the build status
[14:08:31.825] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:31.825] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:82:0) after 1m0s
[14:09:31.907] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:82:0)
[14:09:31.907] Timer tick, asking Buildbucket for the build status
[14:09:32.395] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:32.395] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:83:0) after 1m0s
[14:10:32.458] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:83:0)
[14:10:32.458] Timer tick, asking Buildbucket for the build status
[14:10:32.583] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:32.583] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:84:0) after 1m0s
[14:11:32.640] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:84:0)
[14:11:32.640] Timer tick, asking Buildbucket for the build status
[14:11:32.791] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:32.791] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:85:0) after 1m0s
[14:12:32.855] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:85:0)
[14:12:32.855] Timer tick, asking Buildbucket for the build status
[14:12:33.019] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:33.019] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:86:0) after 1m0s
[14:13:33.065] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:86:0)
[14:13:33.065] Timer tick, asking Buildbucket for the build status
[14:13:33.182] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:33.182] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:87:0) after 1m0s
[14:14:33.169] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:87:0)
[14:14:33.169] Timer tick, asking Buildbucket for the build status
[14:14:33.321] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:33.321] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:88:0) after 1m0s
[14:15:33.428] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:88:0)
[14:15:33.428] Timer tick, asking Buildbucket for the build status
[14:15:33.517] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:33.517] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:89:0) after 1m0s
[14:16:33.596] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:89:0)
[14:16:33.596] Timer tick, asking Buildbucket for the build status
[14:16:33.792] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:33.792] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:90:0) after 1m0s
[14:17:33.991] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:90:0)
[14:17:33.991] Timer tick, asking Buildbucket for the build status
[14:17:34.107] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:34.107] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:91:0) after 1m0s
[14:18:34.164] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:91:0)
[14:18:34.164] Timer tick, asking Buildbucket for the build status
[14:18:34.349] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:34.349] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:92:0) after 1m0s
[14:19:34.377] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:92:0)
[14:19:34.377] Timer tick, asking Buildbucket for the build status
[14:19:34.577] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:34.577] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:93:0) after 1m0s
[14:20:34.631] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:93:0)
[14:20:34.632] Timer tick, asking Buildbucket for the build status
[14:20:34.800] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:34.800] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:94:0) after 1m0s
[14:21:34.850] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:94:0)
[14:21:34.850] Timer tick, asking Buildbucket for the build status
[14:21:34.932] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:34.932] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:95:0) after 1m0s
[14:22:34.983] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:95:0)
[14:22:34.983] Timer tick, asking Buildbucket for the build status
[14:22:35.064] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:35.064] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:96:0) after 1m0s
[14:23:35.176] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:96:0)
[14:23:35.176] Timer tick, asking Buildbucket for the build status
[14:23:35.282] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:35.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:97:0) after 1m0s
[14:24:35.306] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:97:0)
[14:24:35.306] Timer tick, asking Buildbucket for the build status
[14:24:35.447] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:35.447] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:98:0) after 1m0s
[14:25:35.477] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:98:0)
[14:25:35.477] Timer tick, asking Buildbucket for the build status
[14:25:35.673] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:35.673] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:99:0) after 1m0s
[14:26:35.726] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:99:0)
[14:26:35.726] Timer tick, asking Buildbucket for the build status
[14:26:35.912] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:35.912] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:100:0) after 1m0s
[14:27:35.941] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:100:0)
[14:27:35.941] Timer tick, asking Buildbucket for the build status
[14:27:36.032] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:36.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:101:0) after 1m0s
[14:28:36.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:101:0)
[14:28:36.113] Timer tick, asking Buildbucket for the build status
[14:28:36.261] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:36.261] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:102:0) after 1m0s
[14:29:36.292] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:102:0)
[14:29:36.292] Timer tick, asking Buildbucket for the build status
[14:29:36.728] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:36.728] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:103:0) after 1m0s
[14:30:36.793] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:103:0)
[14:30:36.793] Timer tick, asking Buildbucket for the build status
[14:30:36.895] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:36.895] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:104:0) after 1m0s
[14:31:36.980] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:104:0)
[14:31:36.980] Timer tick, asking Buildbucket for the build status
[14:31:37.110] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:37.110] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:105:0) after 1m0s
[14:32:37.205] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:105:0)
[14:32:37.205] Timer tick, asking Buildbucket for the build status
[14:32:37.409] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:37.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:106:0) after 1m0s
[14:33:37.513] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:106:0)
[14:33:37.513] Timer tick, asking Buildbucket for the build status
[14:33:37.632] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:37.632] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:107:0) after 1m0s
[14:34:37.771] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:107:0)
[14:34:37.771] Timer tick, asking Buildbucket for the build status
[14:34:38.471] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:38.472] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:108:0) after 1m0s
[14:35:38.557] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:108:0)
[14:35:38.557] Timer tick, asking Buildbucket for the build status
[14:35:38.890] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:38.890] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:109:0) after 1m0s
[14:36:38.923] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:109:0)
[14:36:38.923] Timer tick, asking Buildbucket for the build status
[14:36:39.212] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:39.212] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:110:0) after 1m0s
[14:37:39.246] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:110:0)
[14:37:39.246] Timer tick, asking Buildbucket for the build status
[14:37:39.337] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:39.337] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:111:0) after 1m0s
[14:38:39.432] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:111:0)
[14:38:39.432] Timer tick, asking Buildbucket for the build status
[14:38:39.547] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:39.547] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:112:0) after 1m0s
[14:39:39.576] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:112:0)
[14:39:39.576] Timer tick, asking Buildbucket for the build status
[14:39:40.370] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:40.370] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:113:0) after 1m0s
[14:40:40.437] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:113:0)
[14:40:40.437] Timer tick, asking Buildbucket for the build status
[14:40:40.732] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:40.732] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:114:0) after 1m0s
[14:41:40.780] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:114:0)
[14:41:40.780] Timer tick, asking Buildbucket for the build status
[14:41:40.880] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:40.880] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:115:0) after 1m0s
[14:42:40.867] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:115:0)
[14:42:40.867] Timer tick, asking Buildbucket for the build status
[14:42:40.949] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:40.949] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:116:0) after 1m0s
[14:43:41.073] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:116:0)
[14:43:41.073] Timer tick, asking Buildbucket for the build status
[14:43:41.175] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:41.175] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:117:0) after 1m0s
[14:44:41.334] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:117:0)
[14:44:41.334] Timer tick, asking Buildbucket for the build status
[14:44:41.509] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:41.509] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:118:0) after 1m0s
[14:45:41.608] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:118:0)
[14:45:41.608] Timer tick, asking Buildbucket for the build status
[14:45:41.723] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:41.723] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:119:0) after 1m0s
[14:46:41.737] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:119:0)
[14:46:41.737] Timer tick, asking Buildbucket for the build status
[14:46:41.836] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:41.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:120:0) after 1m0s
[14:47:41.892] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:120:0)
[14:47:41.892] Timer tick, asking Buildbucket for the build status
[14:47:41.998] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:41.998] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:121:0) after 1m0s
[14:48:41.985] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:121:0)
[14:48:41.985] Timer tick, asking Buildbucket for the build status
[14:48:42.547] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:42.547] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:122:0) after 1m0s
[14:49:42.552] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:122:0)
[14:49:42.552] Timer tick, asking Buildbucket for the build status
[14:49:42.703] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:42.703] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:123:0) after 1m0s
[14:50:42.739] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:123:0)
[14:50:42.739] Timer tick, asking Buildbucket for the build status
[14:50:43.327] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:43.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:124:0) after 1m0s
[14:51:43.319] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:124:0)
[14:51:43.319] Timer tick, asking Buildbucket for the build status
[14:51:43.400] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:43.400] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:125:0) after 1m0s
[14:52:43.614] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:125:0)
[14:52:43.614] Timer tick, asking Buildbucket for the build status
[14:52:43.832] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:43.832] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:126:0) after 1m0s
[14:53:43.870] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:126:0)
[14:53:43.870] Timer tick, asking Buildbucket for the build status
[14:53:44.571] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:44.571] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:127:0) after 1m0s
[14:54:44.631] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:127:0)
[14:54:44.631] Timer tick, asking Buildbucket for the build status
[14:54:45.334] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:45.334] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:128:0) after 1m0s
[14:55:45.328] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:128:0)
[14:55:45.328] Timer tick, asking Buildbucket for the build status
[14:55:45.416] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:45.416] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:129:0) after 1m0s
[14:56:45.444] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:129:0)
[14:56:45.444] Timer tick, asking Buildbucket for the build status
[14:56:45.557] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:45.557] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:130:0) after 1m0s
[14:57:45.583] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:130:0)
[14:57:45.583] Timer tick, asking Buildbucket for the build status
[14:57:45.699] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:45.699] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:131:0) after 1m0s
[14:58:45.749] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:131:0)
[14:58:45.749] Timer tick, asking Buildbucket for the build status
[14:58:45.856] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:45.856] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:132:0) after 1m0s
[14:59:45.895] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:132:0)
[14:59:45.895] Timer tick, asking Buildbucket for the build status
[14:59:46.052] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:46.052] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:133:0) after 1m0s
[15:00:46.124] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:133:0)
[15:00:46.124] Timer tick, asking Buildbucket for the build status
[15:00:46.218] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:46.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:134:0) after 1m0s
[15:01:46.270] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:134:0)
[15:01:46.270] Timer tick, asking Buildbucket for the build status
[15:01:46.342] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:46.342] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:135:0) after 1m0s
[15:02:46.374] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:135:0)
[15:02:46.374] Timer tick, asking Buildbucket for the build status
[15:02:46.535] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:46.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:136:0) after 1m0s
[15:03:46.661] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:136:0)
[15:03:46.661] Timer tick, asking Buildbucket for the build status
[15:03:46.801] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:46.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:137:0) after 1m0s
[15:04:46.837] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:137:0)
[15:04:46.837] Timer tick, asking Buildbucket for the build status
[15:04:47.483] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:47.483] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:138:0) after 1m0s
[15:05:47.662] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:138:0)
[15:05:47.663] Timer tick, asking Buildbucket for the build status
[15:05:47.753] Build 8870267282861864672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:47.754] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9035697345178819888:139:0) after 1m0s
[15:06:40.547] Received PubSub notification, asking Buildbucket for the build status
[15:06:40.669] Build 8870267282861864672: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:06:40.669] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1599059199541472",
"created_by": "project:r8",
"created_ts": "1599050934883886",
"failure_reason": "BUILD_FAILURE",
"id": "8870267282861864672",
"parameters_json": "{\"builder_name\": \"linux-internal\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"c21263224469be5b35c4591375fe0180c38073d4\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@c21263224469be5b35c4591375fe0180c38073d4\", \"title\": \"c21263224469be5b35c4591375fe0180c38073d4\", \"url\": \"https://r8.googlesource.com/r8/+/c21263224469be5b35c4591375fe0180c38073d4\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"265e18fda96020afb1fbb2903e96324992f8a27b\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@265e18fda96020afb1fbb2903e96324992f8a27b\", \"title\": \"265e18fda96020afb1fbb2903e96324992f8a27b\", \"url\": \"https://r8.googlesource.com/r8/+/265e18fda96020afb1fbb2903e96324992f8a27b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"87c903d1d88b581d8935c3c017666db996598a28\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@87c903d1d88b581d8935c3c017666db996598a28\", \"title\": \"87c903d1d88b581d8935c3c017666db996598a28\", \"url\": \"https://r8.googlesource.com/r8/+/87c903d1d88b581d8935c3c017666db996598a28\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"4c6808ac1d139829417e2218881f9ff9c3b7d650\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@4c6808ac1d139829417e2218881f9ff9c3b7d650\", \"title\": \"4c6808ac1d139829417e2218881f9ff9c3b7d650\", \"url\": \"https://r8.googlesource.com/r8/+/4c6808ac1d139829417e2218881f9ff9c3b7d650\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"1a23cf1a2a55e9ac104c7cb3e8503420937155d6\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@1a23cf1a2a55e9ac104c7cb3e8503420937155d6\", \"title\": \"1a23cf1a2a55e9ac104c7cb3e8503420937155d6\", \"url\": \"https://r8.googlesource.com/r8/+/1a23cf1a2a55e9ac104c7cb3e8503420937155d6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"65edb6f1caa1fc76bbb292f6827427e9a4f81110\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@65edb6f1caa1fc76bbb292f6827427e9a4f81110\", \"title\": \"65edb6f1caa1fc76bbb292f6827427e9a4f81110\", \"url\": \"https://r8.googlesource.com/r8/+/65edb6f1caa1fc76bbb292f6827427e9a4f81110\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"65edb6f1caa1fc76bbb292f6827427e9a4f81110\"}}",
"project": "r8",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('Run internal') (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\": \"c21263224469be5b35c4591375fe0180c38073d4\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@c21263224469be5b35c4591375fe0180c38073d4\", \"title\": \"c21263224469be5b35c4591375fe0180c38073d4\", \"url\": \"https://r8.googlesource.com/r8/+/c21263224469be5b35c4591375fe0180c38073d4\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"265e18fda96020afb1fbb2903e96324992f8a27b\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@265e18fda96020afb1fbb2903e96324992f8a27b\", \"title\": \"265e18fda96020afb1fbb2903e96324992f8a27b\", \"url\": \"https://r8.googlesource.com/r8/+/265e18fda96020afb1fbb2903e96324992f8a27b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"87c903d1d88b581d8935c3c017666db996598a28\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@87c903d1d88b581d8935c3c017666db996598a28\", \"title\": \"87c903d1d88b581d8935c3c017666db996598a28\", \"url\": \"https://r8.googlesource.com/r8/+/87c903d1d88b581d8935c3c017666db996598a28\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"4c6808ac1d139829417e2218881f9ff9c3b7d650\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@4c6808ac1d139829417e2218881f9ff9c3b7d650\", \"title\": \"4c6808ac1d139829417e2218881f9ff9c3b7d650\", \"url\": \"https://r8.googlesource.com/r8/+/4c6808ac1d139829417e2218881f9ff9c3b7d650\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"1a23cf1a2a55e9ac104c7cb3e8503420937155d6\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@1a23cf1a2a55e9ac104c7cb3e8503420937155d6\", \"title\": \"1a23cf1a2a55e9ac104c7cb3e8503420937155d6\", \"url\": \"https://r8.googlesource.com/r8/+/1a23cf1a2a55e9ac104c7cb3e8503420937155d6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"65edb6f1caa1fc76bbb292f6827427e9a4f81110\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@65edb6f1caa1fc76bbb292f6827427e9a4f81110\", \"title\": \"65edb6f1caa1fc76bbb292f6827427e9a4f81110\", \"url\": \"https://r8.googlesource.com/r8/+/65edb6f1caa1fc76bbb292f6827427e9a4f81110\"}]}, \"bot_id\": \"luci-r8-custom-ci-internal-0-u7fs\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-internal\", \"buildnumber\": 1279, \"internal\": \"True\", \"mastername\": \"internal.client.r8\", \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"65edb6f1caa1fc76bbb292f6827427e9a4f81110\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_900ab73f001a0fd66671af46f52d62d2e286e9fa85c81d9145d576573008cd6c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"2\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"r8bot-265908\"], \"gpu\": [\"none\"], \"id\": [\"luci-r8-custom-ci-internal-0-u7fs\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"inside_docker\": [\"0\"], \"internal\": [\"true\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-2\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.r8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5507-6e8d655\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-a\"]}}, \"ui\": {\"info\": \"Step('Run internal') (retcode: 1)\"}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1599050979653443",
"status": "COMPLETED",
"status_changed_ts": "1599050979981315",
"tags": [
"build_address:luci.r8.ci/linux-internal/1279",
"builder:linux-internal",
"buildset:commit/git/65edb6f1caa1fc76bbb292f6827427e9a4f81110",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/65edb6f1caa1fc76bbb292f6827427e9a4f81110",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035697345178819888",
"scheduler_job_id:r8/linux-internal",
"swarming_hostname:chrome-swarming.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/r8/buildbucket/cr-buildbucket.appspot.com/8870267282861864672/+/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:4e67ae7a1d8b2210",
"user_agent:luci-scheduler"
],
"updated_ts": "1599059200221637",
"url": "https://ci.chromium.org/b/8870267282861864672",
"utcnow_ts": "1599059200658482"
}
}
[15:06:40.669] Invocation finished in 2h17m47.378748785s with status FAILED