[14:44:56.957] New invocation is queued and will start shortly
[14:44:58.033] Starting the invocation (attempt 1)
[14:44:58.109] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:44:58.109] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:44:58.109] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9075824499375899920",
"parameters_json": "{\"builder_name\":\"linux-internal\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"8c8bcf0a778909feb67405fced7417727b4da389\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-internal",
"scheduler_invocation_id:9075824499375899920",
"scheduler_job_id:r8/linux-internal",
"user_agent:luci-scheduler",
"buildset:commit/git/8c8bcf0a778909feb67405fced7417727b4da389",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/8c8bcf0a778909feb67405fced7417727b4da389",
"gitiles_ref:refs/heads/master"
]
}
[14:44:58.809] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1560782698195512",
"id": "8910394437415418976",
"parameters_json": "{\"builder_name\": \"linux-internal\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"8c8bcf0a778909feb67405fced7417727b4da389\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1560782698689749",
"tags": [
"build_address:luci.r8.ci/linux-internal/320",
"builder:linux-internal",
"buildset:commit/git/8c8bcf0a778909feb67405fced7417727b4da389",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/8c8bcf0a778909feb67405fced7417727b4da389",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075824499375899920",
"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/8910394437415418976/+/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": "1560782698689831",
"url": "https://ci.chromium.org/b/8910394437415418976",
"utcnow_ts": "1560782698801574"
}
}
[14:44:58.809] Task URL: https://ci.chromium.org/b/8910394437415418976
[14:44:58.809] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:2:0) after 1m0s
[14:45:24.914] Received PubSub notification, asking Buildbucket for the build status
[14:45:25.461] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:58.863] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:2:0)
[14:45:58.863] Timer tick, asking Buildbucket for the build status
[14:45:59.303] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:59.303] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:4:0) after 1m0s
[14:46:59.484] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:4:0)
[14:46:59.484] Timer tick, asking Buildbucket for the build status
[14:47:00.395] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:00.396] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:5:0) after 1m0s
[14:48:00.690] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:5:0)
[14:48:00.690] Timer tick, asking Buildbucket for the build status
[14:48:01.157] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:01.157] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:6:0) after 1m0s
[14:49:01.296] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:6:0)
[14:49:01.296] Timer tick, asking Buildbucket for the build status
[14:49:01.689] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:01.689] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:7:0) after 1m0s
[14:50:01.743] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:7:0)
[14:50:01.743] Timer tick, asking Buildbucket for the build status
[14:50:02.111] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:02.111] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:8:0) after 1m0s
[14:51:02.132] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:8:0)
[14:51:02.132] Timer tick, asking Buildbucket for the build status
[14:51:02.332] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:02.332] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:9:0) after 1m0s
[14:52:02.351] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:9:0)
[14:52:02.351] Timer tick, asking Buildbucket for the build status
[14:52:02.453] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:02.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:10:0) after 1m0s
[14:53:02.527] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:10:0)
[14:53:02.527] Timer tick, asking Buildbucket for the build status
[14:53:03.167] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:03.167] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:11:0) after 1m0s
[14:54:03.179] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:11:0)
[14:54:03.179] Timer tick, asking Buildbucket for the build status
[14:54:03.235] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:03.235] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:12:0) after 1m0s
[14:55:03.301] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:12:0)
[14:55:03.301] Timer tick, asking Buildbucket for the build status
[14:55:03.669] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:03.669] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:13:0) after 1m0s
[14:56:03.685] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:13:0)
[14:56:03.686] Timer tick, asking Buildbucket for the build status
[14:56:03.810] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:03.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:14:0) after 1m0s
[14:57:03.953] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:14:0)
[14:57:03.953] Timer tick, asking Buildbucket for the build status
[14:57:04.600] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:04.600] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:15:0) after 1m0s
[14:58:04.642] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:15:0)
[14:58:04.642] Timer tick, asking Buildbucket for the build status
[14:58:04.725] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:04.725] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:16:0) after 1m0s
[14:59:04.756] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:16:0)
[14:59:04.756] Timer tick, asking Buildbucket for the build status
[14:59:04.999] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:04.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:17:0) after 1m0s
[15:00:05.025] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:17:0)
[15:00:05.025] Timer tick, asking Buildbucket for the build status
[15:00:05.102] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:05.102] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:18:0) after 1m0s
[15:01:05.274] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:18:0)
[15:01:05.274] Timer tick, asking Buildbucket for the build status
[15:01:05.413] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:05.413] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:19:0) after 1m0s
[15:02:05.528] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:19:0)
[15:02:05.528] Timer tick, asking Buildbucket for the build status
[15:02:08.859] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:08.859] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:20:0) after 1m0s
[15:03:08.879] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:20:0)
[15:03:08.879] Timer tick, asking Buildbucket for the build status
[15:03:09.637] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:09.637] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:21:0) after 1m0s
[15:04:09.657] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:21:0)
[15:04:09.657] Timer tick, asking Buildbucket for the build status
[15:04:09.997] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:09.997] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:22:0) after 1m0s
[15:05:10.045] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:22:0)
[15:05:10.045] Timer tick, asking Buildbucket for the build status
[15:05:10.215] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:10.215] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:23:0) after 1m0s
[15:06:10.292] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:23:0)
[15:06:10.292] Timer tick, asking Buildbucket for the build status
[15:06:13.015] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:13.015] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:24:0) after 1m0s
[15:07:13.205] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:24:0)
[15:07:13.205] Timer tick, asking Buildbucket for the build status
[15:07:13.760] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:13.760] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:25:0) after 1m0s
[15:08:13.765] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:25:0)
[15:08:13.765] Timer tick, asking Buildbucket for the build status
[15:08:14.056] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:14.056] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:26:0) after 1m0s
[15:09:14.176] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:26:0)
[15:09:14.176] Timer tick, asking Buildbucket for the build status
[15:09:14.737] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:14.737] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:27:0) after 1m0s
[15:10:14.819] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:27:0)
[15:10:14.819] Timer tick, asking Buildbucket for the build status
[15:10:15.344] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:15.344] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:28:0) after 1m0s
[15:11:15.392] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:28:0)
[15:11:15.392] Timer tick, asking Buildbucket for the build status
[15:11:15.583] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:15.584] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:29:0) after 1m0s
[15:12:15.666] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:29:0)
[15:12:15.666] Timer tick, asking Buildbucket for the build status
[15:12:16.253] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:16.253] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:30:0) after 1m0s
[15:13:16.271] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:30:0)
[15:13:16.271] Timer tick, asking Buildbucket for the build status
[15:13:16.329] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:16.329] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:31:0) after 1m0s
[15:14:16.353] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:31:0)
[15:14:16.353] Timer tick, asking Buildbucket for the build status
[15:14:16.474] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:16.474] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:32:0) after 1m0s
[15:15:16.524] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:32:0)
[15:15:16.524] Timer tick, asking Buildbucket for the build status
[15:15:17.477] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:17.477] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:33:0) after 1m0s
[15:16:17.466] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:33:0)
[15:16:17.466] Timer tick, asking Buildbucket for the build status
[15:16:17.529] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:17.529] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:34:0) after 1m0s
[15:17:17.709] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:34:0)
[15:17:17.709] Timer tick, asking Buildbucket for the build status
[15:17:17.948] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:17.948] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:35:0) after 1m0s
[15:18:18.022] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:35:0)
[15:18:18.022] Timer tick, asking Buildbucket for the build status
[15:18:18.174] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:18.174] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:36:0) after 1m0s
[15:19:18.195] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:36:0)
[15:19:18.195] Timer tick, asking Buildbucket for the build status
[15:19:19.139] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:19.139] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:37:0) after 1m0s
[15:20:19.156] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:37:0)
[15:20:19.156] Timer tick, asking Buildbucket for the build status
[15:20:19.248] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:19.248] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:38:0) after 1m0s
[15:21:19.265] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:38:0)
[15:21:19.265] Timer tick, asking Buildbucket for the build status
[15:21:19.336] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:19.336] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:39:0) after 1m0s
[15:22:19.389] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:39:0)
[15:22:19.389] Timer tick, asking Buildbucket for the build status
[15:22:20.163] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:20.163] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:40:0) after 1m0s
[15:23:20.223] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:40:0)
[15:23:20.223] Timer tick, asking Buildbucket for the build status
[15:23:20.373] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:20.374] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:41:0) after 1m0s
[15:24:20.459] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:41:0)
[15:24:20.459] Timer tick, asking Buildbucket for the build status
[15:24:20.668] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:20.668] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:42:0) after 1m0s
[15:25:20.748] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:42:0)
[15:25:20.748] Timer tick, asking Buildbucket for the build status
[15:25:21.008] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:21.008] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:43:0) after 1m0s
[15:26:21.033] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:43:0)
[15:26:21.033] Timer tick, asking Buildbucket for the build status
[15:26:21.188] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:21.188] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:44:0) after 1m0s
[15:27:21.355] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:44:0)
[15:27:21.355] Timer tick, asking Buildbucket for the build status
[15:27:22.314] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:22.314] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:45:0) after 1m0s
[15:28:22.321] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:45:0)
[15:28:22.321] Timer tick, asking Buildbucket for the build status
[15:28:22.813] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:22.813] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:46:0) after 1m0s
[15:29:22.803] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:46:0)
[15:29:22.803] Timer tick, asking Buildbucket for the build status
[15:29:22.972] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:22.972] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:47:0) after 1m0s
[15:30:22.965] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:47:0)
[15:30:22.965] Timer tick, asking Buildbucket for the build status
[15:30:23.202] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:23.202] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:48:0) after 1m0s
[15:31:23.343] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:48:0)
[15:31:23.343] Timer tick, asking Buildbucket for the build status
[15:31:23.437] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:23.437] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:49:0) after 1m0s
[15:32:23.434] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:49:0)
[15:32:23.434] Timer tick, asking Buildbucket for the build status
[15:32:23.572] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:23.572] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:50:0) after 1m0s
[15:33:23.621] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:50:0)
[15:33:23.621] Timer tick, asking Buildbucket for the build status
[15:33:23.797] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:23.797] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:51:0) after 1m0s
[15:34:23.850] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:51:0)
[15:34:23.850] Timer tick, asking Buildbucket for the build status
[15:34:23.941] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:23.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:52:0) after 1m0s
[15:35:23.959] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:52:0)
[15:35:23.959] Timer tick, asking Buildbucket for the build status
[15:35:24.326] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:24.326] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:53:0) after 1m0s
[15:36:24.386] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:53:0)
[15:36:24.386] Timer tick, asking Buildbucket for the build status
[15:36:24.647] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:24.647] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:54:0) after 1m0s
[15:37:24.669] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:54:0)
[15:37:24.669] Timer tick, asking Buildbucket for the build status
[15:37:24.754] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:24.754] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:55:0) after 1m0s
[15:38:24.853] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:55:0)
[15:38:24.853] Timer tick, asking Buildbucket for the build status
[15:38:25.027] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:25.027] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:56:0) after 1m0s
[15:39:25.090] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:56:0)
[15:39:25.090] Timer tick, asking Buildbucket for the build status
[15:39:25.200] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:25.200] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:57:0) after 1m0s
[15:40:25.232] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:57:0)
[15:40:25.232] Timer tick, asking Buildbucket for the build status
[15:40:25.385] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:25.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:58:0) after 1m0s
[15:41:25.452] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:58:0)
[15:41:25.452] Timer tick, asking Buildbucket for the build status
[15:41:25.694] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:25.694] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:59:0) after 1m0s
[15:42:25.714] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:59:0)
[15:42:25.714] Timer tick, asking Buildbucket for the build status
[15:42:25.887] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:25.887] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:60:0) after 1m0s
[15:43:25.910] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:60:0)
[15:43:25.910] Timer tick, asking Buildbucket for the build status
[15:43:26.969] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:26.969] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:61:0) after 1m0s
[15:44:26.982] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:61:0)
[15:44:26.982] Timer tick, asking Buildbucket for the build status
[15:44:27.073] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:27.073] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:62:0) after 1m0s
[15:45:27.096] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:62:0)
[15:45:27.096] Timer tick, asking Buildbucket for the build status
[15:45:27.572] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:27.572] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:63:0) after 1m0s
[15:46:27.643] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:63:0)
[15:46:27.643] Timer tick, asking Buildbucket for the build status
[15:46:27.703] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:27.703] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:64:0) after 1m0s
[15:47:27.697] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:64:0)
[15:47:27.697] Timer tick, asking Buildbucket for the build status
[15:47:27.782] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:27.782] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:65:0) after 1m0s
[15:48:27.977] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:65:0)
[15:48:27.977] Timer tick, asking Buildbucket for the build status
[15:48:28.159] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:28.159] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:66:0) after 1m0s
[15:49:28.257] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:66:0)
[15:49:28.257] Timer tick, asking Buildbucket for the build status
[15:49:28.756] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:28.756] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:67:0) after 1m0s
[15:50:28.847] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:67:0)
[15:50:28.847] Timer tick, asking Buildbucket for the build status
[15:50:29.139] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:29.139] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:68:0) after 1m0s
[15:51:29.233] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:68:0)
[15:51:29.233] Timer tick, asking Buildbucket for the build status
[15:51:29.497] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:29.497] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:69:0) after 1m0s
[15:52:29.515] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:69:0)
[15:52:29.515] Timer tick, asking Buildbucket for the build status
[15:52:29.624] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:29.624] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:70:0) after 1m0s
[15:53:29.653] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:70:0)
[15:53:29.653] Timer tick, asking Buildbucket for the build status
[15:53:29.851] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:29.851] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:71:0) after 1m0s
[15:54:29.874] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:71:0)
[15:54:29.874] Timer tick, asking Buildbucket for the build status
[15:54:29.935] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:29.935] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:72:0) after 1m0s
[15:55:30.073] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:72:0)
[15:55:30.073] Timer tick, asking Buildbucket for the build status
[15:55:30.717] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:30.717] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:73:0) after 1m0s
[15:56:30.921] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:73:0)
[15:56:30.921] Timer tick, asking Buildbucket for the build status
[15:56:31.409] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:31.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:74:0) after 1m0s
[15:57:31.567] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:74:0)
[15:57:31.567] Timer tick, asking Buildbucket for the build status
[15:57:31.877] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:31.877] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:75:0) after 1m0s
[15:58:31.906] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:75:0)
[15:58:31.906] Timer tick, asking Buildbucket for the build status
[15:58:32.064] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:32.064] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:76:0) after 1m0s
[15:59:32.054] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:76:0)
[15:59:32.054] Timer tick, asking Buildbucket for the build status
[15:59:32.122] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:32.122] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:77:0) after 1m0s
[16:00:32.179] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:77:0)
[16:00:32.179] Timer tick, asking Buildbucket for the build status
[16:00:32.245] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:32.245] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:78:0) after 1m0s
[16:01:32.283] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:78:0)
[16:01:32.283] Timer tick, asking Buildbucket for the build status
[16:01:32.418] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:32.418] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:79:0) after 1m0s
[16:02:32.398] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:79:0)
[16:02:32.398] Timer tick, asking Buildbucket for the build status
[16:02:32.596] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:32.596] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:80:0) after 1m0s
[16:03:32.623] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:80:0)
[16:03:32.623] Timer tick, asking Buildbucket for the build status
[16:03:32.787] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:32.787] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:81:0) after 1m0s
[16:04:32.811] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:81:0)
[16:04:32.811] Timer tick, asking Buildbucket for the build status
[16:04:32.926] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:32.926] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:82:0) after 1m0s
[16:05:32.949] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:82:0)
[16:05:32.949] Timer tick, asking Buildbucket for the build status
[16:05:33.018] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:33.018] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:83:0) after 1m0s
[16:06:33.054] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:83:0)
[16:06:33.054] Timer tick, asking Buildbucket for the build status
[16:06:33.364] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:33.364] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:84:0) after 1m0s
[16:07:33.388] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:84:0)
[16:07:33.388] Timer tick, asking Buildbucket for the build status
[16:07:33.772] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:33.772] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:85:0) after 1m0s
[16:08:33.853] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:85:0)
[16:08:33.853] Timer tick, asking Buildbucket for the build status
[16:08:34.213] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:34.213] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:86:0) after 1m0s
[16:09:34.302] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:86:0)
[16:09:34.302] Timer tick, asking Buildbucket for the build status
[16:09:34.440] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:34.440] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:87:0) after 1m0s
[16:10:34.494] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:87:0)
[16:10:34.494] Timer tick, asking Buildbucket for the build status
[16:10:35.070] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:35.070] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:88:0) after 1m0s
[16:11:35.071] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:88:0)
[16:11:35.071] Timer tick, asking Buildbucket for the build status
[16:11:35.169] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:35.169] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:89:0) after 1m0s
[16:12:35.195] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:89:0)
[16:12:35.195] Timer tick, asking Buildbucket for the build status
[16:12:35.929] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:35.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:90:0) after 1m0s
[16:13:35.967] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:90:0)
[16:13:35.967] Timer tick, asking Buildbucket for the build status
[16:13:36.452] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:36.452] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:91:0) after 1m0s
[16:14:36.521] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:91:0)
[16:14:36.521] Timer tick, asking Buildbucket for the build status
[16:14:36.576] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:36.576] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:92:0) after 1m0s
[16:15:36.614] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:92:0)
[16:15:36.614] Timer tick, asking Buildbucket for the build status
[16:15:36.659] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:36.659] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:93:0) after 1m0s
[16:16:36.645] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:93:0)
[16:16:36.645] Timer tick, asking Buildbucket for the build status
[16:16:36.711] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:36.711] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:94:0) after 1m0s
[16:17:36.866] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:94:0)
[16:17:36.866] Timer tick, asking Buildbucket for the build status
[16:17:37.159] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:37.159] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:95:0) after 1m0s
[16:18:37.222] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:95:0)
[16:18:37.222] Timer tick, asking Buildbucket for the build status
[16:18:37.284] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:37.284] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:96:0) after 1m0s
[16:19:37.314] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:96:0)
[16:19:37.314] Timer tick, asking Buildbucket for the build status
[16:19:37.433] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:37.433] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:97:0) after 1m0s
[16:20:37.524] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:97:0)
[16:20:37.524] Timer tick, asking Buildbucket for the build status
[16:20:37.603] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:37.603] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:98:0) after 1m0s
[16:21:37.620] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:98:0)
[16:21:37.620] Timer tick, asking Buildbucket for the build status
[16:21:37.676] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:37.676] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:99:0) after 1m0s
[16:22:37.689] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:99:0)
[16:22:37.689] Timer tick, asking Buildbucket for the build status
[16:22:38.119] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:38.119] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:100:0) after 1m0s
[16:23:38.136] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:100:0)
[16:23:38.136] Timer tick, asking Buildbucket for the build status
[16:23:38.208] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:38.208] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:101:0) after 1m0s
[16:24:38.295] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:101:0)
[16:24:38.295] Timer tick, asking Buildbucket for the build status
[16:24:38.397] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:38.397] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:102:0) after 1m0s
[16:25:38.425] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:102:0)
[16:25:38.425] Timer tick, asking Buildbucket for the build status
[16:25:38.497] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:38.497] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:103:0) after 1m0s
[16:26:38.880] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:103:0)
[16:26:38.880] Timer tick, asking Buildbucket for the build status
[16:26:40.065] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:40.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:104:0) after 1m0s
[16:27:40.103] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:104:0)
[16:27:40.103] Timer tick, asking Buildbucket for the build status
[16:27:40.346] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:40.346] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:105:0) after 1m0s
[16:28:40.438] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:105:0)
[16:28:40.438] Timer tick, asking Buildbucket for the build status
[16:28:40.543] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:40.543] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:106:0) after 1m0s
[16:29:40.784] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:106:0)
[16:29:40.784] Timer tick, asking Buildbucket for the build status
[16:29:41.650] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:41.650] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:107:0) after 1m0s
[16:30:42.379] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:107:0)
[16:30:42.379] Timer tick, asking Buildbucket for the build status
[16:30:42.481] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:42.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:108:0) after 1m0s
[16:31:42.585] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:108:0)
[16:31:42.585] Timer tick, asking Buildbucket for the build status
[16:31:42.647] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:42.647] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:109:0) after 1m0s
[16:32:42.820] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:109:0)
[16:32:42.820] Timer tick, asking Buildbucket for the build status
[16:32:42.885] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:42.885] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:110:0) after 1m0s
[16:33:43.187] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:110:0)
[16:33:43.187] Timer tick, asking Buildbucket for the build status
[16:33:43.653] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:43.653] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:111:0) after 1m0s
[16:34:44.789] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:111:0)
[16:34:44.789] Timer tick, asking Buildbucket for the build status
[16:34:44.887] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:44.887] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:112:0) after 1m0s
[16:35:45.054] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:112:0)
[16:35:45.054] Timer tick, asking Buildbucket for the build status
[16:35:45.154] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:45.154] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:113:0) after 1m0s
[16:36:45.463] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:113:0)
[16:36:45.463] Timer tick, asking Buildbucket for the build status
[16:36:45.521] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:45.521] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:114:0) after 1m0s
[16:37:45.646] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:114:0)
[16:37:45.646] Timer tick, asking Buildbucket for the build status
[16:37:46.219] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:46.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:115:0) after 1m0s
[16:38:46.421] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:115:0)
[16:38:46.421] Timer tick, asking Buildbucket for the build status
[16:38:46.474] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:46.474] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:116:0) after 1m0s
[16:39:46.830] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:116:0)
[16:39:46.830] Timer tick, asking Buildbucket for the build status
[16:39:46.881] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:46.881] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:117:0) after 1m0s
[16:40:47.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:117:0)
[16:40:47.113] Timer tick, asking Buildbucket for the build status
[16:40:47.453] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:47.453] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:118:0) after 1m0s
[16:41:47.478] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:118:0)
[16:41:47.478] Timer tick, asking Buildbucket for the build status
[16:41:47.578] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:47.578] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:119:0) after 1m0s
[16:42:47.646] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:119:0)
[16:42:47.646] Timer tick, asking Buildbucket for the build status
[16:42:47.697] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:47.697] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:120:0) after 1m0s
[16:43:47.723] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:120:0)
[16:43:47.723] Timer tick, asking Buildbucket for the build status
[16:43:47.800] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:47.800] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:121:0) after 1m0s
[16:44:47.822] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:121:0)
[16:44:47.822] Timer tick, asking Buildbucket for the build status
[16:44:48.141] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:48.141] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:122:0) after 1m0s
[16:45:48.230] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:122:0)
[16:45:48.230] Timer tick, asking Buildbucket for the build status
[16:45:48.367] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:48.367] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:123:0) after 1m0s
[16:46:48.504] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:123:0)
[16:46:48.504] Timer tick, asking Buildbucket for the build status
[16:46:48.885] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:48.885] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:124:0) after 1m0s
[16:47:48.942] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:124:0)
[16:47:48.942] Timer tick, asking Buildbucket for the build status
[16:47:49.335] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:49.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:125:0) after 1m0s
[16:48:49.410] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:125:0)
[16:48:49.410] Timer tick, asking Buildbucket for the build status
[16:48:49.545] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:49.545] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:126:0) after 1m0s
[16:49:49.570] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:126:0)
[16:49:49.570] Timer tick, asking Buildbucket for the build status
[16:49:49.745] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:49.745] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:127:0) after 1m0s
[16:50:49.770] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:127:0)
[16:50:49.770] Timer tick, asking Buildbucket for the build status
[16:50:50.138] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:50.138] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:128:0) after 1m0s
[16:51:50.192] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:128:0)
[16:51:50.192] Timer tick, asking Buildbucket for the build status
[16:51:50.320] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:50.320] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:129:0) after 1m0s
[16:52:50.433] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:129:0)
[16:52:50.433] Timer tick, asking Buildbucket for the build status
[16:52:50.512] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:50.512] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:130:0) after 1m0s
[16:53:50.623] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:130:0)
[16:53:50.623] Timer tick, asking Buildbucket for the build status
[16:53:50.735] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:50.736] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:131:0) after 1m0s
[16:54:50.891] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:131:0)
[16:54:50.891] Timer tick, asking Buildbucket for the build status
[16:54:50.966] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:50.966] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:132:0) after 1m0s
[16:55:51.047] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:132:0)
[16:55:51.047] Timer tick, asking Buildbucket for the build status
[16:55:51.112] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:51.112] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:133:0) after 1m0s
[16:56:51.133] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:133:0)
[16:56:51.133] Timer tick, asking Buildbucket for the build status
[16:56:51.336] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:51.336] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:134:0) after 1m0s
[16:57:51.354] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:134:0)
[16:57:51.354] Timer tick, asking Buildbucket for the build status
[16:57:51.569] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:51.569] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:135:0) after 1m0s
[16:58:51.590] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:135:0)
[16:58:51.590] Timer tick, asking Buildbucket for the build status
[16:58:51.826] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:51.826] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:136:0) after 1m0s
[16:59:51.919] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:136:0)
[16:59:51.919] Timer tick, asking Buildbucket for the build status
[16:59:52.297] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:52.297] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:137:0) after 1m0s
[17:00:52.317] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:137:0)
[17:00:52.317] Timer tick, asking Buildbucket for the build status
[17:00:52.550] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:52.550] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:138:0) after 1m0s
[17:01:52.577] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:138:0)
[17:01:52.577] Timer tick, asking Buildbucket for the build status
[17:01:52.625] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:52.625] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:139:0) after 1m0s
[17:02:52.686] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:139:0)
[17:02:52.686] Timer tick, asking Buildbucket for the build status
[17:02:52.813] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:52.813] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:140:0) after 1m0s
[17:03:52.842] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:140:0)
[17:03:52.842] Timer tick, asking Buildbucket for the build status
[17:03:53.224] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:53.224] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:141:0) after 1m0s
[17:04:53.310] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:141:0)
[17:04:53.310] Timer tick, asking Buildbucket for the build status
[17:04:53.956] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:53.956] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:142:0) after 1m0s
[17:05:54.041] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:142:0)
[17:05:54.041] Timer tick, asking Buildbucket for the build status
[17:05:54.111] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:54.111] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:143:0) after 1m0s
[17:06:54.175] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:143:0)
[17:06:54.175] Timer tick, asking Buildbucket for the build status
[17:06:54.278] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:54.278] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:144:0) after 1m0s
[17:07:54.343] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:144:0)
[17:07:54.343] Timer tick, asking Buildbucket for the build status
[17:07:54.520] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:54.520] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:145:0) after 1m0s
[17:08:54.713] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:145:0)
[17:08:54.713] Timer tick, asking Buildbucket for the build status
[17:08:55.630] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:55.630] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:146:0) after 1m0s
[17:09:55.653] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:146:0)
[17:09:55.654] Timer tick, asking Buildbucket for the build status
[17:09:55.733] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:55.733] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:147:0) after 1m0s
[17:10:55.951] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:147:0)
[17:10:55.951] Timer tick, asking Buildbucket for the build status
[17:10:56.127] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:56.127] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:148:0) after 1m0s
[17:11:56.164] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:148:0)
[17:11:56.164] Timer tick, asking Buildbucket for the build status
[17:11:56.471] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:56.471] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:149:0) after 1m0s
[17:12:56.526] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:149:0)
[17:12:56.526] Timer tick, asking Buildbucket for the build status
[17:12:56.612] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:56.612] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:150:0) after 1m0s
[17:13:56.665] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:150:0)
[17:13:56.665] Timer tick, asking Buildbucket for the build status
[17:13:57.406] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:57.406] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:151:0) after 1m0s
[17:14:57.396] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:151:0)
[17:14:57.396] Timer tick, asking Buildbucket for the build status
[17:14:57.457] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:57.457] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:152:0) after 1m0s
[17:15:57.512] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:152:0)
[17:15:57.513] Timer tick, asking Buildbucket for the build status
[17:15:57.599] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:57.599] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:153:0) after 1m0s
[17:16:57.624] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:153:0)
[17:16:57.624] Timer tick, asking Buildbucket for the build status
[17:16:57.702] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:57.702] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:154:0) after 1m0s
[17:17:57.748] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:154:0)
[17:17:57.748] Timer tick, asking Buildbucket for the build status
[17:17:57.797] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:57.797] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:155:0) after 1m0s
[17:18:57.863] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:155:0)
[17:18:57.863] Timer tick, asking Buildbucket for the build status
[17:18:57.995] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:57.995] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:156:0) after 1m0s
[17:19:58.078] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:156:0)
[17:19:58.078] Timer tick, asking Buildbucket for the build status
[17:19:58.197] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:58.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:157:0) after 1m0s
[17:20:58.226] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:157:0)
[17:20:58.226] Timer tick, asking Buildbucket for the build status
[17:20:59.034] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:59.034] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:158:0) after 1m0s
[17:21:59.100] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:158:0)
[17:21:59.100] Timer tick, asking Buildbucket for the build status
[17:21:59.514] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:59.514] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:159:0) after 1m0s
[17:22:59.528] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:159:0)
[17:22:59.528] Timer tick, asking Buildbucket for the build status
[17:23:00.582] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:00.582] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:160:0) after 1m0s
[17:24:00.606] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:160:0)
[17:24:00.606] Timer tick, asking Buildbucket for the build status
[17:24:00.994] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:00.994] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:161:0) after 1m0s
[17:25:00.977] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:161:0)
[17:25:00.977] Timer tick, asking Buildbucket for the build status
[17:25:01.953] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:01.953] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:162:0) after 1m0s
[17:26:01.934] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:162:0)
[17:26:01.934] Timer tick, asking Buildbucket for the build status
[17:26:02.008] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:02.008] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:163:0) after 1m0s
[17:27:02.064] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:163:0)
[17:27:02.064] Timer tick, asking Buildbucket for the build status
[17:27:02.188] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:02.188] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:164:0) after 1m0s
[17:28:02.211] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:164:0)
[17:28:02.211] Timer tick, asking Buildbucket for the build status
[17:28:02.281] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:02.281] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:165:0) after 1m0s
[17:29:02.296] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:165:0)
[17:29:02.296] Timer tick, asking Buildbucket for the build status
[17:29:02.383] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:02.383] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:166:0) after 1m0s
[17:30:02.419] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:166:0)
[17:30:02.419] Timer tick, asking Buildbucket for the build status
[17:30:02.522] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:02.522] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:167:0) after 1m0s
[17:31:02.677] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:167:0)
[17:31:02.677] Timer tick, asking Buildbucket for the build status
[17:31:03.282] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:03.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:168:0) after 1m0s
[17:32:03.346] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:168:0)
[17:32:03.346] Timer tick, asking Buildbucket for the build status
[17:32:03.413] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:03.413] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:169:0) after 1m0s
[17:33:03.501] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:169:0)
[17:33:03.501] Timer tick, asking Buildbucket for the build status
[17:33:03.718] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:03.718] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:170:0) after 1m0s
[17:34:03.748] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:170:0)
[17:34:03.748] Timer tick, asking Buildbucket for the build status
[17:34:03.813] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:03.813] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:171:0) after 1m0s
[17:35:03.982] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:171:0)
[17:35:03.982] Timer tick, asking Buildbucket for the build status
[17:35:04.282] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:04.282] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:172:0) after 1m0s
[17:36:04.368] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:172:0)
[17:36:04.368] Timer tick, asking Buildbucket for the build status
[17:36:05.628] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:05.628] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:173:0) after 1m0s
[17:37:05.659] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:173:0)
[17:37:05.659] Timer tick, asking Buildbucket for the build status
[17:37:05.798] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:05.798] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:174:0) after 1m0s
[17:38:05.814] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:174:0)
[17:38:05.814] Timer tick, asking Buildbucket for the build status
[17:38:05.870] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:05.870] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:175:0) after 1m0s
[17:39:06.044] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:175:0)
[17:39:06.044] Timer tick, asking Buildbucket for the build status
[17:39:06.144] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:06.144] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:176:0) after 1m0s
[17:40:06.366] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:176:0)
[17:40:06.366] Timer tick, asking Buildbucket for the build status
[17:40:06.448] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:06.448] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:177:0) after 1m0s
[17:41:06.570] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:177:0)
[17:41:06.570] Timer tick, asking Buildbucket for the build status
[17:41:06.729] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:06.729] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:178:0) after 1m0s
[17:42:06.887] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:178:0)
[17:42:06.887] Timer tick, asking Buildbucket for the build status
[17:42:07.004] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:07.004] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:179:0) after 1m0s
[17:43:07.031] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:179:0)
[17:43:07.031] Timer tick, asking Buildbucket for the build status
[17:43:07.092] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:07.092] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:180:0) after 1m0s
[17:44:07.146] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:180:0)
[17:44:07.146] Timer tick, asking Buildbucket for the build status
[17:44:07.264] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:07.264] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:181:0) after 1m0s
[17:45:07.367] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:181:0)
[17:45:07.367] Timer tick, asking Buildbucket for the build status
[17:45:07.731] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:07.731] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:182:0) after 1m0s
[17:46:07.751] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:182:0)
[17:46:07.751] Timer tick, asking Buildbucket for the build status
[17:46:08.365] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:08.365] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:183:0) after 1m0s
[17:47:08.433] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:183:0)
[17:47:08.433] Timer tick, asking Buildbucket for the build status
[17:47:08.487] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:08.487] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:184:0) after 1m0s
[17:48:08.492] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:184:0)
[17:48:08.492] Timer tick, asking Buildbucket for the build status
[17:48:08.858] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:08.858] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:185:0) after 1m0s
[17:49:08.919] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:185:0)
[17:49:08.919] Timer tick, asking Buildbucket for the build status
[17:49:10.271] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:10.271] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:186:0) after 1m0s
[17:50:10.335] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:186:0)
[17:50:10.335] Timer tick, asking Buildbucket for the build status
[17:50:10.561] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:10.561] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:187:0) after 1m0s
[17:51:10.576] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:187:0)
[17:51:10.576] Timer tick, asking Buildbucket for the build status
[17:51:10.630] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:10.630] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:188:0) after 1m0s
[17:52:10.686] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:188:0)
[17:52:10.686] Timer tick, asking Buildbucket for the build status
[17:52:10.736] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:10.736] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:189:0) after 1m0s
[17:53:10.820] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:189:0)
[17:53:10.820] Timer tick, asking Buildbucket for the build status
[17:53:11.854] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:11.854] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:190:0) after 1m0s
[17:54:11.930] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:190:0)
[17:54:11.930] Timer tick, asking Buildbucket for the build status
[17:54:12.041] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:12.042] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:191:0) after 1m0s
[17:55:12.187] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:191:0)
[17:55:12.187] Timer tick, asking Buildbucket for the build status
[17:55:12.324] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:12.324] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:192:0) after 1m0s
[17:56:12.467] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:192:0)
[17:56:12.467] Timer tick, asking Buildbucket for the build status
[17:56:12.747] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:12.747] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:193:0) after 1m0s
[17:57:13.059] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:193:0)
[17:57:13.059] Timer tick, asking Buildbucket for the build status
[17:57:14.615] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:14.615] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:194:0) after 1m0s
[17:58:14.671] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:194:0)
[17:58:14.671] Timer tick, asking Buildbucket for the build status
[17:58:14.753] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:14.753] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:195:0) after 1m0s
[17:59:14.880] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:195:0)
[17:59:14.880] Timer tick, asking Buildbucket for the build status
[17:59:15.039] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:15.039] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:196:0) after 1m0s
[18:00:15.226] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:196:0)
[18:00:15.226] Timer tick, asking Buildbucket for the build status
[18:00:15.958] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:15.958] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:197:0) after 1m0s
[18:01:15.994] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:197:0)
[18:01:15.994] Timer tick, asking Buildbucket for the build status
[18:01:16.094] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:16.094] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:198:0) after 1m0s
[18:02:16.148] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:198:0)
[18:02:16.148] Timer tick, asking Buildbucket for the build status
[18:02:16.245] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:16.245] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:199:0) after 1m0s
[18:03:16.366] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:199:0)
[18:03:16.366] Timer tick, asking Buildbucket for the build status
[18:03:17.165] Build 8910394437415418976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:17.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9075824499375899920:200:0) after 1m0s
[18:04:16.532] Received PubSub notification, asking Buildbucket for the build status
[18:04:16.745] Build 8910394437415418976: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:04:16.745] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1560794652025450",
"created_by": "project:r8",
"created_ts": "1560782698195512",
"id": "8910394437415418976",
"parameters_json": "{\"builder_name\": \"linux-internal\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"8c8bcf0a778909feb67405fced7417727b4da389\"}}",
"project": "r8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-r8-ci-internal-0-bdhv\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-internal\", \"buildnumber\": 320, \"internal\": \"True\", \"mastername\": \"internal.client.r8\", \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"8c8bcf0a778909feb67405fced7417727b4da389\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-r8-ci-internal-0-bdhv\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"internal\": [\"true\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.r8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4339-6285c57\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1560782724090042",
"status": "COMPLETED",
"status_changed_ts": "1560794655417863",
"tags": [
"build_address:luci.r8.ci/linux-internal/320",
"builder:linux-internal",
"buildset:commit/git/8c8bcf0a778909feb67405fced7417727b4da389",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/8c8bcf0a778909feb67405fced7417727b4da389",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075824499375899920",
"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/8910394437415418976/+/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:457eb782bb3b9410",
"user_agent:luci-scheduler"
],
"updated_ts": "1560794655422501",
"url": "https://ci.chromium.org/b/8910394437415418976",
"utcnow_ts": "1560794656724703"
}
}
[18:04:16.745] Invocation finished in 3h19m19.803456568s with status SUCCEEDED