[06:20:03.022] New invocation is queued and will start shortly
[06:20:04.340] Starting the invocation (attempt 1)
[06:20:04.387] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:20:04.387] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:20:04.388] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9034453451227633648",
"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\":\"723e7f0d15cd9bb6086f629da118835f44c0dbaa\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@723e7f0d15cd9bb6086f629da118835f44c0dbaa\",\"title\":\"723e7f0d15cd9bb6086f629da118835f44c0dbaa\",\"url\":\"https://r8.googlesource.com/r8/+/723e7f0d15cd9bb6086f629da118835f44c0dbaa\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"723e7f0d15cd9bb6086f629da118835f44c0dbaa\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-internal",
"scheduler_invocation_id:9034453451227633648",
"scheduler_job_id:r8/linux-internal",
"user_agent:luci-scheduler",
"buildset:commit/git/723e7f0d15cd9bb6086f629da118835f44c0dbaa",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/723e7f0d15cd9bb6086f629da118835f44c0dbaa",
"gitiles_ref:refs/heads/master"
]
}
[06:20:05.294] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1600237204505801",
"id": "8869023389006841632",
"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\": \"723e7f0d15cd9bb6086f629da118835f44c0dbaa\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@723e7f0d15cd9bb6086f629da118835f44c0dbaa\", \"title\": \"723e7f0d15cd9bb6086f629da118835f44c0dbaa\", \"url\": \"https://r8.googlesource.com/r8/+/723e7f0d15cd9bb6086f629da118835f44c0dbaa\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"723e7f0d15cd9bb6086f629da118835f44c0dbaa\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600237205017531",
"tags": [
"build_address:luci.r8.ci/linux-internal/1314",
"builder:linux-internal",
"buildset:commit/git/723e7f0d15cd9bb6086f629da118835f44c0dbaa",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/723e7f0d15cd9bb6086f629da118835f44c0dbaa",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034453451227633648",
"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/8869023389006841632/+/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": "1600237205017636",
"url": "https://ci.chromium.org/b/8869023389006841632",
"utcnow_ts": "1600237205276281"
}
}
[06:20:05.294] Task URL: https://ci.chromium.org/b/8869023389006841632
[06:20:05.294] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:2:0) after 1m0s
[06:20:18.682] Received PubSub notification, asking Buildbucket for the build status
[06:20:19.243] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:05.329] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:2:0)
[06:21:05.329] Timer tick, asking Buildbucket for the build status
[06:21:05.661] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:05.661] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:4:0) after 1m0s
[06:22:05.699] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:4:0)
[06:22:05.699] Timer tick, asking Buildbucket for the build status
[06:22:05.997] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:05.997] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:5:0) after 1m0s
[06:23:06.031] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:5:0)
[06:23:06.031] Timer tick, asking Buildbucket for the build status
[06:23:06.113] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:06.114] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:6:0) after 1m0s
[06:24:06.155] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:6:0)
[06:24:06.155] Timer tick, asking Buildbucket for the build status
[06:24:06.287] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:06.287] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:7:0) after 1m0s
[06:25:06.343] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:7:0)
[06:25:06.343] Timer tick, asking Buildbucket for the build status
[06:25:06.468] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:06.468] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:8:0) after 1m0s
[06:26:06.485] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:8:0)
[06:26:06.485] Timer tick, asking Buildbucket for the build status
[06:26:06.752] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:06.752] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:9:0) after 1m0s
[06:27:06.802] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:9:0)
[06:27:06.802] Timer tick, asking Buildbucket for the build status
[06:27:06.878] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:06.878] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:10:0) after 1m0s
[06:28:07.003] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:10:0)
[06:28:07.003] Timer tick, asking Buildbucket for the build status
[06:28:07.124] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:07.124] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:11:0) after 1m0s
[06:29:07.119] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:11:0)
[06:29:07.119] Timer tick, asking Buildbucket for the build status
[06:29:07.178] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:07.178] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:12:0) after 1m0s
[06:30:07.309] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:12:0)
[06:30:07.309] Timer tick, asking Buildbucket for the build status
[06:30:07.448] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:07.449] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:13:0) after 1m0s
[06:31:07.518] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:13:0)
[06:31:07.518] Timer tick, asking Buildbucket for the build status
[06:31:07.913] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:07.913] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:14:0) after 1m0s
[06:32:07.984] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:14:0)
[06:32:07.984] Timer tick, asking Buildbucket for the build status
[06:32:08.252] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:08.252] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:15:0) after 1m0s
[06:33:08.289] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:15:0)
[06:33:08.289] Timer tick, asking Buildbucket for the build status
[06:33:08.487] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:08.487] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:16:0) after 1m0s
[06:34:08.544] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:16:0)
[06:34:08.544] Timer tick, asking Buildbucket for the build status
[06:34:08.678] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:08.678] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:17:0) after 1m0s
[06:35:08.975] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:17:0)
[06:35:08.975] Timer tick, asking Buildbucket for the build status
[06:35:09.176] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:09.177] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:18:0) after 1m0s
[06:36:09.304] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:18:0)
[06:36:09.304] Timer tick, asking Buildbucket for the build status
[06:36:09.600] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:09.600] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:19:0) after 1m0s
[06:37:09.656] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:19:0)
[06:37:09.656] Timer tick, asking Buildbucket for the build status
[06:37:09.874] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:09.874] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:20:0) after 1m0s
[06:38:10.004] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:20:0)
[06:38:10.004] Timer tick, asking Buildbucket for the build status
[06:38:10.111] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:10.111] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:21:0) after 1m0s
[06:39:10.141] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:21:0)
[06:39:10.141] Timer tick, asking Buildbucket for the build status
[06:39:10.281] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:10.281] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:22:0) after 1m0s
[06:40:10.330] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:22:0)
[06:40:10.330] Timer tick, asking Buildbucket for the build status
[06:40:11.598] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:11.598] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:23:0) after 1m0s
[06:41:11.623] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:23:0)
[06:41:11.623] Timer tick, asking Buildbucket for the build status
[06:41:11.717] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:11.717] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:24:0) after 1m0s
[06:42:11.785] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:24:0)
[06:42:11.785] Timer tick, asking Buildbucket for the build status
[06:42:11.876] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:11.876] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:25:0) after 1m0s
[06:43:11.971] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:25:0)
[06:43:11.971] Timer tick, asking Buildbucket for the build status
[06:43:12.080] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:12.080] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:26:0) after 1m0s
[06:44:12.151] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:26:0)
[06:44:12.151] Timer tick, asking Buildbucket for the build status
[06:44:12.282] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:12.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:27:0) after 1m0s
[06:45:12.305] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:27:0)
[06:45:12.305] Timer tick, asking Buildbucket for the build status
[06:45:12.409] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:12.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:28:0) after 1m0s
[06:46:12.471] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:28:0)
[06:46:12.471] Timer tick, asking Buildbucket for the build status
[06:46:12.559] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:12.559] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:29:0) after 1m0s
[06:47:12.603] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:29:0)
[06:47:12.603] Timer tick, asking Buildbucket for the build status
[06:47:13.098] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:13.098] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:30:0) after 1m0s
[06:48:13.129] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:30:0)
[06:48:13.129] Timer tick, asking Buildbucket for the build status
[06:48:13.213] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:13.213] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:31:0) after 1m0s
[06:49:13.251] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:31:0)
[06:49:13.251] Timer tick, asking Buildbucket for the build status
[06:49:13.342] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:13.342] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:32:0) after 1m0s
[06:50:13.367] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:32:0)
[06:50:13.367] Timer tick, asking Buildbucket for the build status
[06:50:13.494] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:13.494] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:33:0) after 1m0s
[06:51:13.546] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:33:0)
[06:51:13.546] Timer tick, asking Buildbucket for the build status
[06:51:13.647] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:13.647] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:34:0) after 1m0s
[06:52:13.835] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:34:0)
[06:52:13.835] Timer tick, asking Buildbucket for the build status
[06:52:13.926] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:13.926] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:35:0) after 1m0s
[06:53:13.969] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:35:0)
[06:53:13.969] Timer tick, asking Buildbucket for the build status
[06:53:14.104] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:14.104] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:36:0) after 1m0s
[06:54:14.159] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:36:0)
[06:54:14.159] Timer tick, asking Buildbucket for the build status
[06:54:14.294] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:14.294] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:37:0) after 1m0s
[06:55:14.392] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:37:0)
[06:55:14.392] Timer tick, asking Buildbucket for the build status
[06:55:14.543] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:14.543] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:38:0) after 1m0s
[06:56:14.563] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:38:0)
[06:56:14.563] Timer tick, asking Buildbucket for the build status
[06:56:14.650] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:14.650] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:39:0) after 1m0s
[06:57:14.700] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:39:0)
[06:57:14.700] Timer tick, asking Buildbucket for the build status
[06:57:16.023] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:16.023] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:40:0) after 1m0s
[06:58:16.044] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:40:0)
[06:58:16.044] Timer tick, asking Buildbucket for the build status
[06:58:16.142] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:16.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:41:0) after 1m0s
[06:59:16.179] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:41:0)
[06:59:16.179] Timer tick, asking Buildbucket for the build status
[06:59:16.283] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:16.283] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:42:0) after 1m0s
[07:00:16.376] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:42:0)
[07:00:16.376] Timer tick, asking Buildbucket for the build status
[07:00:17.188] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:17.188] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:43:0) after 1m0s
[07:01:17.212] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:43:0)
[07:01:17.212] Timer tick, asking Buildbucket for the build status
[07:01:17.312] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:17.312] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:44:0) after 1m0s
[07:02:17.295] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:44:0)
[07:02:17.295] Timer tick, asking Buildbucket for the build status
[07:02:17.404] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:17.404] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:45:0) after 1m0s
[07:03:17.463] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:45:0)
[07:03:17.463] Timer tick, asking Buildbucket for the build status
[07:03:18.062] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:18.062] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:46:0) after 1m0s
[07:04:18.127] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:46:0)
[07:04:18.127] Timer tick, asking Buildbucket for the build status
[07:04:18.443] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:18.443] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:47:0) after 1m0s
[07:05:18.488] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:47:0)
[07:05:18.488] Timer tick, asking Buildbucket for the build status
[07:05:18.743] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:18.743] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:48:0) after 1m0s
[07:06:18.791] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:48:0)
[07:06:18.791] Timer tick, asking Buildbucket for the build status
[07:06:19.100] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:19.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:49:0) after 1m0s
[07:07:19.105] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:49:0)
[07:07:19.106] Timer tick, asking Buildbucket for the build status
[07:07:19.192] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:19.192] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:50:0) after 1m0s
[07:08:19.246] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:50:0)
[07:08:19.246] Timer tick, asking Buildbucket for the build status
[07:08:20.651] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:20.651] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:51:0) after 1m0s
[07:09:20.680] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:51:0)
[07:09:20.680] Timer tick, asking Buildbucket for the build status
[07:09:20.739] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:20.739] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:52:0) after 1m0s
[07:10:20.780] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:52:0)
[07:10:20.780] Timer tick, asking Buildbucket for the build status
[07:10:21.008] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:21.008] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:53:0) after 1m0s
[07:11:21.063] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:53:0)
[07:11:21.063] Timer tick, asking Buildbucket for the build status
[07:11:21.272] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:21.272] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:54:0) after 1m0s
[07:12:21.318] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:54:0)
[07:12:21.318] Timer tick, asking Buildbucket for the build status
[07:12:21.399] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:21.399] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:55:0) after 1m0s
[07:13:21.411] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:55:0)
[07:13:21.411] Timer tick, asking Buildbucket for the build status
[07:13:21.518] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:21.518] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:56:0) after 1m0s
[07:14:21.536] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:56:0)
[07:14:21.536] Timer tick, asking Buildbucket for the build status
[07:14:21.599] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:21.599] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:57:0) after 1m0s
[07:15:21.678] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:57:0)
[07:15:21.678] Timer tick, asking Buildbucket for the build status
[07:15:21.826] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:21.826] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:58:0) after 1m0s
[07:16:21.903] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:58:0)
[07:16:21.903] Timer tick, asking Buildbucket for the build status
[07:16:21.992] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:21.992] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:59:0) after 1m0s
[07:17:22.250] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:59:0)
[07:17:22.250] Timer tick, asking Buildbucket for the build status
[07:17:22.360] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:22.360] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:60:0) after 1m0s
[07:18:22.554] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:60:0)
[07:18:22.554] Timer tick, asking Buildbucket for the build status
[07:18:22.621] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:22.621] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:61:0) after 1m0s
[07:19:22.688] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:61:0)
[07:19:22.688] Timer tick, asking Buildbucket for the build status
[07:19:22.900] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:22.900] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:62:0) after 1m0s
[07:20:23.119] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:62:0)
[07:20:23.119] Timer tick, asking Buildbucket for the build status
[07:20:23.266] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:23.266] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:63:0) after 1m0s
[07:21:23.380] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:63:0)
[07:21:23.380] Timer tick, asking Buildbucket for the build status
[07:21:23.458] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:23.458] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:64:0) after 1m0s
[07:22:23.553] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:64:0)
[07:22:23.553] Timer tick, asking Buildbucket for the build status
[07:22:25.563] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:25.563] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:65:0) after 1m0s
[07:23:25.678] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:65:0)
[07:23:25.678] Timer tick, asking Buildbucket for the build status
[07:23:25.753] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:25.753] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:66:0) after 1m0s
[07:24:25.795] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:66:0)
[07:24:25.795] Timer tick, asking Buildbucket for the build status
[07:24:26.196] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:26.196] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:67:0) after 1m0s
[07:25:26.219] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:67:0)
[07:25:26.219] Timer tick, asking Buildbucket for the build status
[07:25:26.405] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:26.405] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:68:0) after 1m0s
[07:26:26.519] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:68:0)
[07:26:26.519] Timer tick, asking Buildbucket for the build status
[07:26:27.029] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:27.029] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:69:0) after 1m0s
[07:27:27.127] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:69:0)
[07:27:27.127] Timer tick, asking Buildbucket for the build status
[07:27:27.210] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:27.210] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:70:0) after 1m0s
[07:28:27.231] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:70:0)
[07:28:27.231] Timer tick, asking Buildbucket for the build status
[07:28:27.337] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:27.337] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:71:0) after 1m0s
[07:29:27.359] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:71:0)
[07:29:27.359] Timer tick, asking Buildbucket for the build status
[07:29:27.437] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:27.437] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:72:0) after 1m0s
[07:30:27.500] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:72:0)
[07:30:27.500] Timer tick, asking Buildbucket for the build status
[07:30:27.699] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:27.699] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:73:0) after 1m0s
[07:31:27.754] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:73:0)
[07:31:27.754] Timer tick, asking Buildbucket for the build status
[07:31:27.871] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:27.871] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:74:0) after 1m0s
[07:32:27.902] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:74:0)
[07:32:27.902] Timer tick, asking Buildbucket for the build status
[07:32:29.624] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:29.624] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:75:0) after 1m0s
[07:33:29.696] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:75:0)
[07:33:29.696] Timer tick, asking Buildbucket for the build status
[07:33:29.854] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:29.854] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:76:0) after 1m0s
[07:34:29.942] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:76:0)
[07:34:29.942] Timer tick, asking Buildbucket for the build status
[07:34:30.233] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:30.233] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:77:0) after 1m0s
[07:35:30.282] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:77:0)
[07:35:30.282] Timer tick, asking Buildbucket for the build status
[07:35:31.857] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:31.857] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:78:0) after 1m0s
[07:36:31.906] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:78:0)
[07:36:31.906] Timer tick, asking Buildbucket for the build status
[07:36:31.974] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:31.974] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:79:0) after 1m0s
[07:37:32.044] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:79:0)
[07:37:32.044] Timer tick, asking Buildbucket for the build status
[07:37:32.132] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:32.132] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:80:0) after 1m0s
[07:38:32.233] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:80:0)
[07:38:32.233] Timer tick, asking Buildbucket for the build status
[07:38:32.330] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:32.330] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:81:0) after 1m0s
[07:39:32.412] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:81:0)
[07:39:32.412] Timer tick, asking Buildbucket for the build status
[07:39:32.494] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:32.494] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:82:0) after 1m0s
[07:40:32.551] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:82:0)
[07:40:32.551] Timer tick, asking Buildbucket for the build status
[07:40:32.678] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:32.678] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:83:0) after 1m0s
[07:41:32.718] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:83:0)
[07:41:32.718] Timer tick, asking Buildbucket for the build status
[07:41:32.803] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:32.803] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:84:0) after 1m0s
[07:42:33.032] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:84:0)
[07:42:33.032] Timer tick, asking Buildbucket for the build status
[07:42:33.931] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:33.931] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:85:0) after 1m0s
[07:43:34.107] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:85:0)
[07:43:34.107] Timer tick, asking Buildbucket for the build status
[07:43:35.928] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:35.928] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:86:0) after 1m0s
[07:44:35.952] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:86:0)
[07:44:35.952] Timer tick, asking Buildbucket for the build status
[07:44:36.138] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:36.138] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:87:0) after 1m0s
[07:45:36.182] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:87:0)
[07:45:36.182] Timer tick, asking Buildbucket for the build status
[07:45:36.335] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:36.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:88:0) after 1m0s
[07:46:36.409] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:88:0)
[07:46:36.409] Timer tick, asking Buildbucket for the build status
[07:46:36.648] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:36.648] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:89:0) after 1m0s
[07:47:36.705] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:89:0)
[07:47:36.705] Timer tick, asking Buildbucket for the build status
[07:47:36.910] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:36.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:90:0) after 1m0s
[07:48:36.907] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:90:0)
[07:48:36.907] Timer tick, asking Buildbucket for the build status
[07:48:36.984] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:36.984] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:91:0) after 1m0s
[07:49:37.039] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:91:0)
[07:49:37.039] Timer tick, asking Buildbucket for the build status
[07:49:37.385] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:37.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:92:0) after 1m0s
[07:50:37.453] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:92:0)
[07:50:37.453] Timer tick, asking Buildbucket for the build status
[07:50:37.605] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:37.605] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:93:0) after 1m0s
[07:51:37.642] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:93:0)
[07:51:37.642] Timer tick, asking Buildbucket for the build status
[07:51:37.891] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:37.891] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:94:0) after 1m0s
[07:52:37.940] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:94:0)
[07:52:37.940] Timer tick, asking Buildbucket for the build status
[07:52:38.028] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:38.029] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:95:0) after 1m0s
[07:53:38.145] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:95:0)
[07:53:38.145] Timer tick, asking Buildbucket for the build status
[07:53:38.206] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:38.206] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:96:0) after 1m0s
[07:54:38.886] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:96:0)
[07:54:38.887] Timer tick, asking Buildbucket for the build status
[07:54:38.967] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:38.967] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:97:0) after 1m0s
[07:55:39.060] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:97:0)
[07:55:39.060] Timer tick, asking Buildbucket for the build status
[07:55:39.174] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:39.174] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:98:0) after 1m0s
[07:56:39.250] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:98:0)
[07:56:39.250] Timer tick, asking Buildbucket for the build status
[07:56:39.341] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:39.341] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:99:0) after 1m0s
[07:57:39.347] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:99:0)
[07:57:39.347] Timer tick, asking Buildbucket for the build status
[07:57:39.582] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:39.582] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:100:0) after 1m0s
[07:58:39.611] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:100:0)
[07:58:39.611] Timer tick, asking Buildbucket for the build status
[07:58:39.902] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:39.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:101:0) after 1m0s
[07:59:39.947] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:101:0)
[07:59:39.947] Timer tick, asking Buildbucket for the build status
[07:59:40.678] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:40.678] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:102:0) after 1m0s
[08:00:40.700] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:102:0)
[08:00:40.700] Timer tick, asking Buildbucket for the build status
[08:00:43.351] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:43.351] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:103:0) after 1m0s
[08:01:43.397] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:103:0)
[08:01:43.397] Timer tick, asking Buildbucket for the build status
[08:01:43.634] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:43.634] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:104:0) after 1m0s
[08:02:43.899] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:104:0)
[08:02:43.899] Timer tick, asking Buildbucket for the build status
[08:02:43.988] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:43.988] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:105:0) after 1m0s
[08:03:44.083] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:105:0)
[08:03:44.083] Timer tick, asking Buildbucket for the build status
[08:03:44.182] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:44.182] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:106:0) after 1m0s
[08:04:44.291] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:106:0)
[08:04:44.291] Timer tick, asking Buildbucket for the build status
[08:04:44.416] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:44.416] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:107:0) after 1m0s
[08:05:44.474] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:107:0)
[08:05:44.474] Timer tick, asking Buildbucket for the build status
[08:05:44.719] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:44.719] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:108:0) after 1m0s
[08:06:44.737] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:108:0)
[08:06:44.737] Timer tick, asking Buildbucket for the build status
[08:06:44.830] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:44.830] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:109:0) after 1m0s
[08:07:44.939] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:109:0)
[08:07:44.939] Timer tick, asking Buildbucket for the build status
[08:07:45.005] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:45.005] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:110:0) after 1m0s
[08:08:45.064] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:110:0)
[08:08:45.064] Timer tick, asking Buildbucket for the build status
[08:08:45.160] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:45.160] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:111:0) after 1m0s
[08:09:45.211] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:111:0)
[08:09:45.211] Timer tick, asking Buildbucket for the build status
[08:09:45.281] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:45.281] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:112:0) after 1m0s
[08:10:45.399] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:112:0)
[08:10:45.399] Timer tick, asking Buildbucket for the build status
[08:10:45.518] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:45.518] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:113:0) after 1m0s
[08:11:45.593] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:113:0)
[08:11:45.593] Timer tick, asking Buildbucket for the build status
[08:11:45.678] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:45.678] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:114:0) after 1m0s
[08:12:45.713] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:114:0)
[08:12:45.713] Timer tick, asking Buildbucket for the build status
[08:12:45.797] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:45.797] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:115:0) after 1m0s
[08:13:45.819] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:115:0)
[08:13:45.819] Timer tick, asking Buildbucket for the build status
[08:13:45.928] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:45.928] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:116:0) after 1m0s
[08:14:45.962] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:116:0)
[08:14:45.962] Timer tick, asking Buildbucket for the build status
[08:14:46.042] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:46.042] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:117:0) after 1m0s
[08:15:46.137] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:117:0)
[08:15:46.137] Timer tick, asking Buildbucket for the build status
[08:15:46.286] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:46.286] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:118:0) after 1m0s
[08:16:46.365] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:118:0)
[08:16:46.365] Timer tick, asking Buildbucket for the build status
[08:16:46.624] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:46.624] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:119:0) after 1m0s
[08:17:46.702] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:119:0)
[08:17:46.702] Timer tick, asking Buildbucket for the build status
[08:17:46.838] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:46.838] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:120:0) after 1m0s
[08:18:47.825] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:120:0)
[08:18:47.825] Timer tick, asking Buildbucket for the build status
[08:18:47.916] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:47.916] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:121:0) after 1m0s
[08:19:48.049] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:121:0)
[08:19:48.049] Timer tick, asking Buildbucket for the build status
[08:19:48.160] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:48.160] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:122:0) after 1m0s
[08:20:48.358] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:122:0)
[08:20:48.358] Timer tick, asking Buildbucket for the build status
[08:20:48.490] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:48.490] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:123:0) after 1m0s
[08:21:49.531] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:123:0)
[08:21:49.531] Timer tick, asking Buildbucket for the build status
[08:21:49.648] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:49.648] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:124:0) after 1m0s
[08:22:49.704] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:124:0)
[08:22:49.704] Timer tick, asking Buildbucket for the build status
[08:22:49.787] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:49.787] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:125:0) after 1m0s
[08:23:49.835] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:125:0)
[08:23:49.835] Timer tick, asking Buildbucket for the build status
[08:23:52.286] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:52.286] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:126:0) after 1m0s
[08:24:52.470] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:126:0)
[08:24:52.470] Timer tick, asking Buildbucket for the build status
[08:24:52.790] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:52.790] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:127:0) after 1m0s
[08:25:52.837] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:127:0)
[08:25:52.837] Timer tick, asking Buildbucket for the build status
[08:25:53.193] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:53.193] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:128:0) after 1m0s
[08:26:53.223] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:128:0)
[08:26:53.223] Timer tick, asking Buildbucket for the build status
[08:26:53.356] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:53.356] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:129:0) after 1m0s
[08:27:53.415] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:129:0)
[08:27:53.415] Timer tick, asking Buildbucket for the build status
[08:27:53.511] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:53.511] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:130:0) after 1m0s
[08:28:53.536] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:130:0)
[08:28:53.536] Timer tick, asking Buildbucket for the build status
[08:28:53.723] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:53.723] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:131:0) after 1m0s
[08:29:53.720] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:131:0)
[08:29:53.720] Timer tick, asking Buildbucket for the build status
[08:29:53.806] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:53.806] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:132:0) after 1m0s
[08:30:53.915] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:132:0)
[08:30:53.915] Timer tick, asking Buildbucket for the build status
[08:30:54.160] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:54.160] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:133:0) after 1m0s
[08:31:54.242] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:133:0)
[08:31:54.242] Timer tick, asking Buildbucket for the build status
[08:31:54.298] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:54.298] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:134:0) after 1m0s
[08:32:54.405] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:134:0)
[08:32:54.405] Timer tick, asking Buildbucket for the build status
[08:32:54.758] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:54.758] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:135:0) after 1m0s
[08:33:54.813] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:135:0)
[08:33:54.813] Timer tick, asking Buildbucket for the build status
[08:33:54.886] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:54.886] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:136:0) after 1m0s
[08:34:54.951] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:136:0)
[08:34:54.951] Timer tick, asking Buildbucket for the build status
[08:34:55.056] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:55.056] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:137:0) after 1m0s
[08:35:55.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:137:0)
[08:35:55.113] Timer tick, asking Buildbucket for the build status
[08:35:55.216] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:55.216] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:138:0) after 1m0s
[08:36:55.282] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:138:0)
[08:36:55.282] Timer tick, asking Buildbucket for the build status
[08:36:55.358] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:55.358] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:139:0) after 1m0s
[08:37:55.427] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:139:0)
[08:37:55.427] Timer tick, asking Buildbucket for the build status
[08:37:55.515] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:55.515] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:140:0) after 1m0s
[08:38:55.543] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:140:0)
[08:38:55.543] Timer tick, asking Buildbucket for the build status
[08:38:55.611] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:55.611] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:141:0) after 1m0s
[08:39:55.678] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:141:0)
[08:39:55.678] Timer tick, asking Buildbucket for the build status
[08:39:55.892] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:55.892] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:142:0) after 1m0s
[08:40:56.051] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:142:0)
[08:40:56.051] Timer tick, asking Buildbucket for the build status
[08:40:56.481] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:56.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:143:0) after 1m0s
[08:41:56.551] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:143:0)
[08:41:56.551] Timer tick, asking Buildbucket for the build status
[08:41:56.681] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:56.682] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:144:0) after 1m0s
[08:42:56.839] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:144:0)
[08:42:56.839] Timer tick, asking Buildbucket for the build status
[08:42:56.894] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:56.894] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:145:0) after 1m0s
[08:43:56.960] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:145:0)
[08:43:56.960] Timer tick, asking Buildbucket for the build status
[08:43:57.052] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:57.052] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:146:0) after 1m0s
[08:44:57.221] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:146:0)
[08:44:57.221] Timer tick, asking Buildbucket for the build status
[08:44:57.286] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:57.286] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:147:0) after 1m0s
[08:45:57.500] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:147:0)
[08:45:57.500] Timer tick, asking Buildbucket for the build status
[08:45:57.639] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:57.639] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:148:0) after 1m0s
[08:46:57.712] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:148:0)
[08:46:57.712] Timer tick, asking Buildbucket for the build status
[08:46:57.868] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:57.868] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:149:0) after 1m0s
[08:47:58.122] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:149:0)
[08:47:58.122] Timer tick, asking Buildbucket for the build status
[08:47:58.263] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:58.263] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:150:0) after 1m0s
[08:48:58.324] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:150:0)
[08:48:58.324] Timer tick, asking Buildbucket for the build status
[08:48:58.436] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:58.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:151:0) after 1m0s
[08:49:58.446] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:151:0)
[08:49:58.446] Timer tick, asking Buildbucket for the build status
[08:49:58.514] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:58.515] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:152:0) after 1m0s
[08:50:58.661] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:152:0)
[08:50:58.661] Timer tick, asking Buildbucket for the build status
[08:50:58.798] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:58.798] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:153:0) after 1m0s
[08:51:58.856] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:153:0)
[08:51:58.856] Timer tick, asking Buildbucket for the build status
[08:51:58.928] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:58.928] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:154:0) after 1m0s
[08:52:59.078] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:154:0)
[08:52:59.078] Timer tick, asking Buildbucket for the build status
[08:52:59.155] Build 8869023389006841632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:59.155] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9034453451227633648:155:0) after 1m0s
[08:53:03.407] Received PubSub notification, asking Buildbucket for the build status
[08:53:03.548] Build 8869023389006841632: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:53:03.548] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1600246383075284",
"created_by": "project:r8",
"created_ts": "1600237204505801",
"failure_reason": "BUILD_FAILURE",
"id": "8869023389006841632",
"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\": \"723e7f0d15cd9bb6086f629da118835f44c0dbaa\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@723e7f0d15cd9bb6086f629da118835f44c0dbaa\", \"title\": \"723e7f0d15cd9bb6086f629da118835f44c0dbaa\", \"url\": \"https://r8.googlesource.com/r8/+/723e7f0d15cd9bb6086f629da118835f44c0dbaa\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"723e7f0d15cd9bb6086f629da118835f44c0dbaa\"}}",
"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\": \"723e7f0d15cd9bb6086f629da118835f44c0dbaa\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@723e7f0d15cd9bb6086f629da118835f44c0dbaa\", \"title\": \"723e7f0d15cd9bb6086f629da118835f44c0dbaa\", \"url\": \"https://r8.googlesource.com/r8/+/723e7f0d15cd9bb6086f629da118835f44c0dbaa\"}]}, \"bot_id\": \"luci-r8-custom-ci-internal-0-yccv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"internal.client.r8\", \"buildername\": \"linux-internal\", \"buildnumber\": 1314, \"internal\": \"True\", \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"723e7f0d15cd9bb6086f629da118835f44c0dbaa\"}, \"swarming\": {\"bot_dimensions\": {\"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-yccv\"], \"image\": [\"chrome-xenial-20091300-9b3346fad90\"], \"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\": [\"5522-67570db\"], \"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": "1600237217299885",
"status": "COMPLETED",
"status_changed_ts": "1600237218316233",
"tags": [
"build_address:luci.r8.ci/linux-internal/1314",
"builder:linux-internal",
"buildset:commit/git/723e7f0d15cd9bb6086f629da118835f44c0dbaa",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/723e7f0d15cd9bb6086f629da118835f44c0dbaa",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034453451227633648",
"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/8869023389006841632/+/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:4eae638645e9f410",
"user_agent:luci-scheduler"
],
"updated_ts": "1600246383153885",
"url": "https://ci.chromium.org/b/8869023389006841632",
"utcnow_ts": "1600246383533056"
}
}
[08:53:03.548] Invocation finished in 2h33m0.544211178s with status FAILED