[07:04:48.588] New invocation is queued and will start shortly
[07:04:50.010] Starting the invocation (attempt 1)
[07:04:50.055] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:04:50.055] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:04:50.055] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9073950912558999728",
"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\":\"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\",\"title\":\"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\",\"url\":\"https://r8.googlesource.com/r8/+/0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-internal",
"scheduler_invocation_id:9073950912558999728",
"scheduler_job_id:r8/linux-internal",
"user_agent:luci-scheduler",
"buildset:commit/git/0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a",
"gitiles_ref:refs/heads/master"
]
}
[07:04:51.133] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1562569490190661",
"id": "8908520850212815696",
"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\": \"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\", \"title\": \"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\", \"url\": \"https://r8.googlesource.com/r8/+/0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1562569490872338",
"tags": [
"build_address:luci.r8.ci/linux-internal/383",
"builder:linux-internal",
"buildset:commit/git/0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073950912558999728",
"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/8908520850212815696/+/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": "1562569490872433",
"url": "https://ci.chromium.org/b/8908520850212815696",
"utcnow_ts": "1562569491090787"
}
}
[07:04:51.133] Task URL: https://ci.chromium.org/b/8908520850212815696
[07:04:51.133] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:2:0) after 1m0s
[07:05:51.483] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:2:0)
[07:05:51.483] Timer tick, asking Buildbucket for the build status
[07:05:51.605] Build 8908520850212815696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:51.605] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:3:0) after 1m0s
[07:05:56.674] Received PubSub notification, asking Buildbucket for the build status
[07:05:56.788] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:51.706] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:3:0)
[07:06:51.706] Timer tick, asking Buildbucket for the build status
[07:06:52.082] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:52.082] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:5:0) after 1m0s
[07:07:52.162] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:5:0)
[07:07:52.163] Timer tick, asking Buildbucket for the build status
[07:07:52.217] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:52.217] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:6:0) after 1m0s
[07:08:52.254] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:6:0)
[07:08:52.254] Timer tick, asking Buildbucket for the build status
[07:08:52.355] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:52.355] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:7:0) after 1m0s
[07:09:52.477] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:7:0)
[07:09:52.477] Timer tick, asking Buildbucket for the build status
[07:09:52.821] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:52.821] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:8:0) after 1m0s
[07:10:52.978] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:8:0)
[07:10:52.978] Timer tick, asking Buildbucket for the build status
[07:10:53.042] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:53.042] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:9:0) after 1m0s
[07:11:53.553] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:9:0)
[07:11:53.553] Timer tick, asking Buildbucket for the build status
[07:11:53.726] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:53.726] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:10:0) after 1m0s
[07:12:54.239] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:10:0)
[07:12:54.239] Timer tick, asking Buildbucket for the build status
[07:12:54.378] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:54.378] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:11:0) after 1m0s
[07:13:54.461] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:11:0)
[07:13:54.461] Timer tick, asking Buildbucket for the build status
[07:13:56.174] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:56.174] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:12:0) after 1m0s
[07:14:56.350] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:12:0)
[07:14:56.350] Timer tick, asking Buildbucket for the build status
[07:14:56.402] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:56.402] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:13:0) after 1m0s
[07:15:56.749] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:13:0)
[07:15:56.749] Timer tick, asking Buildbucket for the build status
[07:15:57.276] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:57.276] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:14:0) after 1m0s
[07:16:57.458] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:14:0)
[07:16:57.458] Timer tick, asking Buildbucket for the build status
[07:16:57.547] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:57.547] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:15:0) after 1m0s
[07:17:57.762] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:15:0)
[07:17:57.762] Timer tick, asking Buildbucket for the build status
[07:17:58.269] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:58.269] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:16:0) after 1m0s
[07:18:58.471] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:16:0)
[07:18:58.471] Timer tick, asking Buildbucket for the build status
[07:18:58.643] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:58.643] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:17:0) after 1m0s
[07:19:58.825] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:17:0)
[07:19:58.825] Timer tick, asking Buildbucket for the build status
[07:19:58.925] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:58.925] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:18:0) after 1m0s
[07:20:59.289] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:18:0)
[07:20:59.289] Timer tick, asking Buildbucket for the build status
[07:20:59.743] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:59.743] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:19:0) after 1m0s
[07:22:00.015] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:19:0)
[07:22:00.015] Timer tick, asking Buildbucket for the build status
[07:22:00.183] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:00.183] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:20:0) after 1m0s
[07:23:00.251] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:20:0)
[07:23:00.251] Timer tick, asking Buildbucket for the build status
[07:23:00.426] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:00.426] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:21:0) after 1m0s
[07:24:00.509] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:21:0)
[07:24:00.509] Timer tick, asking Buildbucket for the build status
[07:24:00.593] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:00.593] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:22:0) after 1m0s
[07:25:01.057] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:22:0)
[07:25:01.057] Timer tick, asking Buildbucket for the build status
[07:25:01.207] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:01.207] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:23:0) after 1m0s
[07:26:01.277] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:23:0)
[07:26:01.277] Timer tick, asking Buildbucket for the build status
[07:26:02.265] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:02.265] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:24:0) after 1m0s
[07:27:02.319] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:24:0)
[07:27:02.319] Timer tick, asking Buildbucket for the build status
[07:27:03.287] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:03.287] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:25:0) after 1m0s
[07:28:03.349] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:25:0)
[07:28:03.349] Timer tick, asking Buildbucket for the build status
[07:28:03.575] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:03.575] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:26:0) after 1m0s
[07:29:03.599] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:26:0)
[07:29:03.599] Timer tick, asking Buildbucket for the build status
[07:29:03.931] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:03.931] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:27:0) after 1m0s
[07:30:03.959] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:27:0)
[07:30:03.959] Timer tick, asking Buildbucket for the build status
[07:30:04.049] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:04.049] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:28:0) after 1m0s
[07:31:04.152] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:28:0)
[07:31:04.152] Timer tick, asking Buildbucket for the build status
[07:31:04.243] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:04.243] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:29:0) after 1m0s
[07:32:04.314] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:29:0)
[07:32:04.314] Timer tick, asking Buildbucket for the build status
[07:32:04.509] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:04.509] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:30:0) after 1m0s
[07:33:04.679] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:30:0)
[07:33:04.679] Timer tick, asking Buildbucket for the build status
[07:33:04.857] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:04.857] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:31:0) after 1m0s
[07:34:04.897] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:31:0)
[07:34:04.897] Timer tick, asking Buildbucket for the build status
[07:34:05.274] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:05.274] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:32:0) after 1m0s
[07:35:05.371] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:32:0)
[07:35:05.371] Timer tick, asking Buildbucket for the build status
[07:35:05.637] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:05.637] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:33:0) after 1m0s
[07:36:05.854] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:33:0)
[07:36:05.854] Timer tick, asking Buildbucket for the build status
[07:36:05.934] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:05.934] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:34:0) after 1m0s
[07:37:05.954] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:34:0)
[07:37:05.954] Timer tick, asking Buildbucket for the build status
[07:37:06.678] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:06.678] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:35:0) after 1m0s
[07:38:06.691] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:35:0)
[07:38:06.691] Timer tick, asking Buildbucket for the build status
[07:38:06.837] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:06.838] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:36:0) after 1m0s
[07:39:06.865] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:36:0)
[07:39:06.865] Timer tick, asking Buildbucket for the build status
[07:39:07.017] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:07.017] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:37:0) after 1m0s
[07:40:07.147] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:37:0)
[07:40:07.147] Timer tick, asking Buildbucket for the build status
[07:40:08.190] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:08.190] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:38:0) after 1m0s
[07:41:08.164] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:38:0)
[07:41:08.164] Timer tick, asking Buildbucket for the build status
[07:41:08.806] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:08.806] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:39:0) after 1m0s
[07:42:08.871] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:39:0)
[07:42:08.871] Timer tick, asking Buildbucket for the build status
[07:42:08.953] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:08.953] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:40:0) after 1m0s
[07:43:09.023] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:40:0)
[07:43:09.023] Timer tick, asking Buildbucket for the build status
[07:43:09.164] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:09.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:41:0) after 1m0s
[07:44:09.209] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:41:0)
[07:44:09.209] Timer tick, asking Buildbucket for the build status
[07:44:09.299] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:09.299] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:42:0) after 1m0s
[07:45:09.328] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:42:0)
[07:45:09.328] Timer tick, asking Buildbucket for the build status
[07:45:09.435] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:09.435] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:43:0) after 1m0s
[07:46:09.455] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:43:0)
[07:46:09.455] Timer tick, asking Buildbucket for the build status
[07:46:09.741] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:09.741] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:44:0) after 1m0s
[07:47:09.803] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:44:0)
[07:47:09.803] Timer tick, asking Buildbucket for the build status
[07:47:10.329] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:10.329] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:45:0) after 1m0s
[07:48:10.358] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:45:0)
[07:48:10.358] Timer tick, asking Buildbucket for the build status
[07:48:11.307] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:11.307] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:46:0) after 1m0s
[07:49:11.385] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:46:0)
[07:49:11.385] Timer tick, asking Buildbucket for the build status
[07:49:11.498] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:11.498] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:47:0) after 1m0s
[07:50:11.527] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:47:0)
[07:50:11.527] Timer tick, asking Buildbucket for the build status
[07:50:11.862] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:11.862] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:48:0) after 1m0s
[07:51:11.995] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:48:0)
[07:51:11.995] Timer tick, asking Buildbucket for the build status
[07:51:12.121] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:12.121] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:49:0) after 1m0s
[07:52:12.154] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:49:0)
[07:52:12.154] Timer tick, asking Buildbucket for the build status
[07:52:13.018] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:13.018] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:50:0) after 1m0s
[07:53:13.044] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:50:0)
[07:53:13.044] Timer tick, asking Buildbucket for the build status
[07:53:13.389] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:13.389] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:51:0) after 1m0s
[07:54:13.468] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:51:0)
[07:54:13.468] Timer tick, asking Buildbucket for the build status
[07:54:13.869] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:13.869] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:52:0) after 1m0s
[07:55:13.909] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:52:0)
[07:55:13.909] Timer tick, asking Buildbucket for the build status
[07:55:14.869] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:14.869] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:53:0) after 1m0s
[07:56:14.898] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:53:0)
[07:56:14.898] Timer tick, asking Buildbucket for the build status
[07:56:14.960] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:14.960] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:54:0) after 1m0s
[07:57:14.997] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:54:0)
[07:57:14.997] Timer tick, asking Buildbucket for the build status
[07:57:15.076] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:15.076] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:55:0) after 1m0s
[07:58:15.200] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:55:0)
[07:58:15.200] Timer tick, asking Buildbucket for the build status
[07:58:15.268] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:15.268] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:56:0) after 1m0s
[07:59:15.294] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:56:0)
[07:59:15.294] Timer tick, asking Buildbucket for the build status
[07:59:15.389] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:15.389] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:57:0) after 1m0s
[08:00:15.418] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:57:0)
[08:00:15.418] Timer tick, asking Buildbucket for the build status
[08:00:15.999] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:15.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:58:0) after 1m0s
[08:01:16.065] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:58:0)
[08:01:16.065] Timer tick, asking Buildbucket for the build status
[08:01:16.234] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:16.234] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:59:0) after 1m0s
[08:02:16.254] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:59:0)
[08:02:16.254] Timer tick, asking Buildbucket for the build status
[08:02:16.673] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:16.673] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:60:0) after 1m0s
[08:03:16.710] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:60:0)
[08:03:16.710] Timer tick, asking Buildbucket for the build status
[08:03:17.076] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:17.076] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:61:0) after 1m0s
[08:04:17.102] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:61:0)
[08:04:17.102] Timer tick, asking Buildbucket for the build status
[08:04:17.924] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:17.924] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:62:0) after 1m0s
[08:05:17.954] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:62:0)
[08:05:17.954] Timer tick, asking Buildbucket for the build status
[08:05:18.113] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:18.113] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:63:0) after 1m0s
[08:06:18.147] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:63:0)
[08:06:18.147] Timer tick, asking Buildbucket for the build status
[08:06:19.427] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:19.427] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:64:0) after 1m0s
[08:07:19.457] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:64:0)
[08:07:19.457] Timer tick, asking Buildbucket for the build status
[08:07:19.712] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:19.712] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:65:0) after 1m0s
[08:08:19.767] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:65:0)
[08:08:19.767] Timer tick, asking Buildbucket for the build status
[08:08:20.437] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:20.437] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:66:0) after 1m0s
[08:09:20.506] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:66:0)
[08:09:20.506] Timer tick, asking Buildbucket for the build status
[08:09:20.706] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:20.706] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:67:0) after 1m0s
[08:10:20.724] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:67:0)
[08:10:20.724] Timer tick, asking Buildbucket for the build status
[08:10:20.801] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:20.801] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:68:0) after 1m0s
[08:11:20.842] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:68:0)
[08:11:20.842] Timer tick, asking Buildbucket for the build status
[08:11:22.164] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:22.164] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:69:0) after 1m0s
[08:12:22.212] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:69:0)
[08:12:22.212] Timer tick, asking Buildbucket for the build status
[08:12:22.357] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:22.357] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:70:0) after 1m0s
[08:13:22.475] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:70:0)
[08:13:22.475] Timer tick, asking Buildbucket for the build status
[08:13:22.639] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:22.639] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:71:0) after 1m0s
[08:14:22.672] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:71:0)
[08:14:22.672] Timer tick, asking Buildbucket for the build status
[08:14:23.026] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:23.026] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:72:0) after 1m0s
[08:15:23.128] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:72:0)
[08:15:23.128] Timer tick, asking Buildbucket for the build status
[08:15:24.238] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:24.238] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:73:0) after 1m0s
[08:16:24.333] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:73:0)
[08:16:24.333] Timer tick, asking Buildbucket for the build status
[08:16:24.445] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:24.445] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:74:0) after 1m0s
[08:17:24.481] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:74:0)
[08:17:24.481] Timer tick, asking Buildbucket for the build status
[08:17:25.259] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:25.259] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:75:0) after 1m0s
[08:18:25.365] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:75:0)
[08:18:25.365] Timer tick, asking Buildbucket for the build status
[08:18:26.624] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:26.624] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:76:0) after 1m0s
[08:19:26.783] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:76:0)
[08:19:26.783] Timer tick, asking Buildbucket for the build status
[08:19:27.331] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:27.331] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:77:0) after 1m0s
[08:20:27.475] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:77:0)
[08:20:27.475] Timer tick, asking Buildbucket for the build status
[08:20:27.600] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:27.600] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:78:0) after 1m0s
[08:21:27.721] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:78:0)
[08:21:27.721] Timer tick, asking Buildbucket for the build status
[08:21:28.534] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:28.534] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:79:0) after 1m0s
[08:22:28.599] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:79:0)
[08:22:28.599] Timer tick, asking Buildbucket for the build status
[08:22:29.362] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:29.362] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:80:0) after 1m0s
[08:23:29.462] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:80:0)
[08:23:29.462] Timer tick, asking Buildbucket for the build status
[08:23:29.556] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:29.556] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:81:0) after 1m0s
[08:24:29.643] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:81:0)
[08:24:29.643] Timer tick, asking Buildbucket for the build status
[08:24:29.892] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:29.892] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:82:0) after 1m0s
[08:25:29.951] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:82:0)
[08:25:29.951] Timer tick, asking Buildbucket for the build status
[08:25:30.943] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:30.944] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:83:0) after 1m0s
[08:26:31.079] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:83:0)
[08:26:31.079] Timer tick, asking Buildbucket for the build status
[08:26:32.841] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:32.841] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:84:0) after 1m0s
[08:27:32.977] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:84:0)
[08:27:32.977] Timer tick, asking Buildbucket for the build status
[08:27:33.482] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:33.482] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:85:0) after 1m0s
[08:28:33.673] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:85:0)
[08:28:33.673] Timer tick, asking Buildbucket for the build status
[08:28:33.922] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:33.922] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:86:0) after 1m0s
[08:29:33.945] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:86:0)
[08:29:33.945] Timer tick, asking Buildbucket for the build status
[08:29:34.036] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:34.036] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:87:0) after 1m0s
[08:30:34.066] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:87:0)
[08:30:34.066] Timer tick, asking Buildbucket for the build status
[08:30:34.178] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:34.178] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:88:0) after 1m0s
[08:31:34.286] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:88:0)
[08:31:34.286] Timer tick, asking Buildbucket for the build status
[08:31:35.497] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:35.497] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:89:0) after 1m0s
[08:32:35.864] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:89:0)
[08:32:35.864] Timer tick, asking Buildbucket for the build status
[08:32:36.032] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:36.032] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:90:0) after 1m0s
[08:33:36.465] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:90:0)
[08:33:36.465] Timer tick, asking Buildbucket for the build status
[08:33:37.380] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:37.380] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:91:0) after 1m0s
[08:34:37.522] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:91:0)
[08:34:37.522] Timer tick, asking Buildbucket for the build status
[08:34:37.902] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:37.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:92:0) after 1m0s
[08:35:38.011] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:92:0)
[08:35:38.011] Timer tick, asking Buildbucket for the build status
[08:35:38.180] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:38.180] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:93:0) after 1m0s
[08:36:38.175] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:93:0)
[08:36:38.175] Timer tick, asking Buildbucket for the build status
[08:36:38.396] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:38.396] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:94:0) after 1m0s
[08:37:38.389] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:94:0)
[08:37:38.389] Timer tick, asking Buildbucket for the build status
[08:37:38.850] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:38.850] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:95:0) after 1m0s
[08:38:38.901] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:95:0)
[08:38:38.901] Timer tick, asking Buildbucket for the build status
[08:38:39.035] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:39.035] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:96:0) after 1m0s
[08:39:39.320] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:96:0)
[08:39:39.320] Timer tick, asking Buildbucket for the build status
[08:39:39.523] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:39.523] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:97:0) after 1m0s
[08:40:39.638] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:97:0)
[08:40:39.638] Timer tick, asking Buildbucket for the build status
[08:40:39.922] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:39.922] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:98:0) after 1m0s
[08:41:40.054] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:98:0)
[08:41:40.054] Timer tick, asking Buildbucket for the build status
[08:41:40.151] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:40.151] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:99:0) after 1m0s
[08:42:40.921] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:99:0)
[08:42:40.922] Timer tick, asking Buildbucket for the build status
[08:42:40.994] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:40.994] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:100:0) after 1m0s
[08:43:41.998] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:100:0)
[08:43:41.999] Timer tick, asking Buildbucket for the build status
[08:43:43.060] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:43.060] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:101:0) after 1m0s
[08:44:43.346] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:101:0)
[08:44:43.346] Timer tick, asking Buildbucket for the build status
[08:44:43.423] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:43.423] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:102:0) after 1m0s
[08:45:43.483] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:102:0)
[08:45:43.483] Timer tick, asking Buildbucket for the build status
[08:45:43.693] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:43.693] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:103:0) after 1m0s
[08:46:43.717] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:103:0)
[08:46:43.717] Timer tick, asking Buildbucket for the build status
[08:46:44.334] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:44.334] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:104:0) after 1m0s
[08:47:44.384] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:104:0)
[08:47:44.384] Timer tick, asking Buildbucket for the build status
[08:47:44.771] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:44.771] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:105:0) after 1m0s
[08:48:44.799] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:105:0)
[08:48:44.799] Timer tick, asking Buildbucket for the build status
[08:48:44.988] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:44.988] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:106:0) after 1m0s
[08:49:45.028] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:106:0)
[08:49:45.028] Timer tick, asking Buildbucket for the build status
[08:49:46.102] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:46.102] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:107:0) after 1m0s
[08:50:46.251] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:107:0)
[08:50:46.251] Timer tick, asking Buildbucket for the build status
[08:50:46.431] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:46.431] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:108:0) after 1m0s
[08:51:46.601] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:108:0)
[08:51:46.601] Timer tick, asking Buildbucket for the build status
[08:51:46.859] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:46.859] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:109:0) after 1m0s
[08:52:47.017] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:109:0)
[08:52:47.017] Timer tick, asking Buildbucket for the build status
[08:52:48.542] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:48.542] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:110:0) after 1m0s
[08:53:48.794] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:110:0)
[08:53:48.794] Timer tick, asking Buildbucket for the build status
[08:53:48.913] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:48.913] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:111:0) after 1m0s
[08:54:49.106] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:111:0)
[08:54:49.106] Timer tick, asking Buildbucket for the build status
[08:54:49.196] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:49.196] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:112:0) after 1m0s
[08:55:49.806] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:112:0)
[08:55:49.806] Timer tick, asking Buildbucket for the build status
[08:55:49.902] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:49.902] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:113:0) after 1m0s
[08:56:50.778] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:113:0)
[08:56:50.778] Timer tick, asking Buildbucket for the build status
[08:56:50.832] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:50.832] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:114:0) after 1m0s
[08:57:50.861] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:114:0)
[08:57:50.861] Timer tick, asking Buildbucket for the build status
[08:57:50.967] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:50.967] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:115:0) after 1m0s
[08:58:50.982] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:115:0)
[08:58:50.982] Timer tick, asking Buildbucket for the build status
[08:58:51.075] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:51.075] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:116:0) after 1m0s
[08:59:51.069] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:116:0)
[08:59:51.069] Timer tick, asking Buildbucket for the build status
[08:59:51.287] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:51.287] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:117:0) after 1m0s
[09:00:51.333] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:117:0)
[09:00:51.333] Timer tick, asking Buildbucket for the build status
[09:00:51.683] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:51.683] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:118:0) after 1m0s
[09:01:51.798] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:118:0)
[09:01:51.798] Timer tick, asking Buildbucket for the build status
[09:01:51.893] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:51.893] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:119:0) after 1m0s
[09:02:52.087] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:119:0)
[09:02:52.087] Timer tick, asking Buildbucket for the build status
[09:02:52.197] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:52.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:120:0) after 1m0s
[09:03:52.382] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:120:0)
[09:03:52.382] Timer tick, asking Buildbucket for the build status
[09:03:52.624] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:52.624] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:121:0) after 1m0s
[09:04:52.950] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:121:0)
[09:04:52.950] Timer tick, asking Buildbucket for the build status
[09:04:53.932] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:53.932] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:122:0) after 1m0s
[09:05:54.092] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:122:0)
[09:05:54.092] Timer tick, asking Buildbucket for the build status
[09:05:54.599] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:54.599] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:123:0) after 1m0s
[09:06:54.780] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:123:0)
[09:06:54.780] Timer tick, asking Buildbucket for the build status
[09:06:54.891] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:54.891] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:124:0) after 1m0s
[09:07:55.152] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:124:0)
[09:07:55.152] Timer tick, asking Buildbucket for the build status
[09:07:55.210] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:55.210] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:125:0) after 1m0s
[09:08:55.371] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:125:0)
[09:08:55.371] Timer tick, asking Buildbucket for the build status
[09:08:55.508] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:55.508] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:126:0) after 1m0s
[09:09:55.523] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:126:0)
[09:09:55.523] Timer tick, asking Buildbucket for the build status
[09:09:55.571] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:55.571] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:127:0) after 1m0s
[09:10:55.647] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:127:0)
[09:10:55.647] Timer tick, asking Buildbucket for the build status
[09:10:55.721] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:55.721] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:128:0) after 1m0s
[09:11:55.902] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:128:0)
[09:11:55.902] Timer tick, asking Buildbucket for the build status
[09:11:56.126] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:56.126] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:129:0) after 1m0s
[09:12:56.188] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:129:0)
[09:12:56.188] Timer tick, asking Buildbucket for the build status
[09:12:56.243] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:56.243] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:130:0) after 1m0s
[09:13:56.640] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:130:0)
[09:13:56.640] Timer tick, asking Buildbucket for the build status
[09:13:56.733] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:56.733] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:131:0) after 1m0s
[09:14:56.769] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:131:0)
[09:14:56.769] Timer tick, asking Buildbucket for the build status
[09:14:56.856] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:56.856] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:132:0) after 1m0s
[09:15:56.906] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:132:0)
[09:15:56.906] Timer tick, asking Buildbucket for the build status
[09:15:57.081] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:57.081] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:133:0) after 1m0s
[09:16:57.103] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:133:0)
[09:16:57.103] Timer tick, asking Buildbucket for the build status
[09:16:57.220] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:57.220] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:134:0) after 1m0s
[09:17:57.237] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:134:0)
[09:17:57.237] Timer tick, asking Buildbucket for the build status
[09:17:59.287] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:59.287] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:135:0) after 1m0s
[09:18:59.389] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:135:0)
[09:18:59.389] Timer tick, asking Buildbucket for the build status
[09:18:59.467] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:59.467] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:136:0) after 1m0s
[09:19:59.761] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:136:0)
[09:19:59.761] Timer tick, asking Buildbucket for the build status
[09:20:00.324] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:00.324] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:137:0) after 1m0s
[09:21:00.442] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:137:0)
[09:21:00.442] Timer tick, asking Buildbucket for the build status
[09:21:00.716] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:00.716] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:138:0) after 1m0s
[09:22:00.770] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:138:0)
[09:22:00.770] Timer tick, asking Buildbucket for the build status
[09:22:00.878] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:00.878] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:139:0) after 1m0s
[09:23:00.919] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:139:0)
[09:23:00.919] Timer tick, asking Buildbucket for the build status
[09:23:01.013] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:01.013] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:140:0) after 1m0s
[09:24:02.201] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:140:0)
[09:24:02.201] Timer tick, asking Buildbucket for the build status
[09:24:02.426] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:02.427] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:141:0) after 1m0s
[09:25:02.708] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:141:0)
[09:25:02.708] Timer tick, asking Buildbucket for the build status
[09:25:02.867] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:02.867] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:142:0) after 1m0s
[09:26:03.023] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:142:0)
[09:26:03.024] Timer tick, asking Buildbucket for the build status
[09:26:03.142] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:03.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:143:0) after 1m0s
[09:27:03.302] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:143:0)
[09:27:03.302] Timer tick, asking Buildbucket for the build status
[09:27:03.421] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:03.421] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:144:0) after 1m0s
[09:28:03.460] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:144:0)
[09:28:03.460] Timer tick, asking Buildbucket for the build status
[09:28:03.641] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:03.641] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:145:0) after 1m0s
[09:29:03.667] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:145:0)
[09:29:03.667] Timer tick, asking Buildbucket for the build status
[09:29:03.852] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:03.852] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:146:0) after 1m0s
[09:30:03.912] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:146:0)
[09:30:03.912] Timer tick, asking Buildbucket for the build status
[09:30:04.129] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:04.129] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:147:0) after 1m0s
[09:31:04.197] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:147:0)
[09:31:04.197] Timer tick, asking Buildbucket for the build status
[09:31:04.547] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:04.547] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:148:0) after 1m0s
[09:32:04.679] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:148:0)
[09:32:04.679] Timer tick, asking Buildbucket for the build status
[09:32:04.778] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:04.778] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:149:0) after 1m0s
[09:33:04.805] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:149:0)
[09:33:04.805] Timer tick, asking Buildbucket for the build status
[09:33:05.220] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:05.220] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:150:0) after 1m0s
[09:34:05.249] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:150:0)
[09:34:05.249] Timer tick, asking Buildbucket for the build status
[09:34:05.436] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:05.436] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:151:0) after 1m0s
[09:35:05.450] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:151:0)
[09:35:05.450] Timer tick, asking Buildbucket for the build status
[09:35:07.430] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:07.430] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:152:0) after 1m0s
[09:36:07.441] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:152:0)
[09:36:07.441] Timer tick, asking Buildbucket for the build status
[09:36:07.553] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:07.553] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:153:0) after 1m0s
[09:37:07.578] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:153:0)
[09:37:07.578] Timer tick, asking Buildbucket for the build status
[09:37:07.663] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:07.663] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:154:0) after 1m0s
[09:38:07.687] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:154:0)
[09:38:07.687] Timer tick, asking Buildbucket for the build status
[09:38:08.538] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:08.538] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:155:0) after 1m0s
[09:39:08.568] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:155:0)
[09:39:08.568] Timer tick, asking Buildbucket for the build status
[09:39:08.676] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:08.676] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:156:0) after 1m0s
[09:40:08.747] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:156:0)
[09:40:08.747] Timer tick, asking Buildbucket for the build status
[09:40:09.152] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:09.152] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:157:0) after 1m0s
[09:41:09.158] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:157:0)
[09:41:09.158] Timer tick, asking Buildbucket for the build status
[09:41:09.622] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:09.622] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:158:0) after 1m0s
[09:42:09.846] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:158:0)
[09:42:09.846] Timer tick, asking Buildbucket for the build status
[09:42:10.065] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:10.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:159:0) after 1m0s
[09:43:10.132] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:159:0)
[09:43:10.132] Timer tick, asking Buildbucket for the build status
[09:43:10.222] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:10.222] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:160:0) after 1m0s
[09:44:10.303] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:160:0)
[09:44:10.303] Timer tick, asking Buildbucket for the build status
[09:44:10.497] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:10.497] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:161:0) after 1m0s
[09:45:10.536] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:161:0)
[09:45:10.536] Timer tick, asking Buildbucket for the build status
[09:45:10.734] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:10.734] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:162:0) after 1m0s
[09:46:10.772] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:162:0)
[09:46:10.772] Timer tick, asking Buildbucket for the build status
[09:46:10.867] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:10.867] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:163:0) after 1m0s
[09:47:10.877] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:163:0)
[09:47:10.877] Timer tick, asking Buildbucket for the build status
[09:47:11.638] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:11.638] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:164:0) after 1m0s
[09:48:11.678] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:164:0)
[09:48:11.678] Timer tick, asking Buildbucket for the build status
[09:48:11.945] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:11.945] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:165:0) after 1m0s
[09:49:11.981] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:165:0)
[09:49:11.981] Timer tick, asking Buildbucket for the build status
[09:49:12.434] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:12.434] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:166:0) after 1m0s
[09:50:12.469] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:166:0)
[09:50:12.469] Timer tick, asking Buildbucket for the build status
[09:50:13.247] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:13.247] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:167:0) after 1m0s
[09:51:13.362] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:167:0)
[09:51:13.362] Timer tick, asking Buildbucket for the build status
[09:51:14.620] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:14.620] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:168:0) after 1m0s
[09:52:14.659] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:168:0)
[09:52:14.659] Timer tick, asking Buildbucket for the build status
[09:52:15.194] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:15.194] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:169:0) after 1m0s
[09:53:15.224] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:169:0)
[09:53:15.224] Timer tick, asking Buildbucket for the build status
[09:53:15.335] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:15.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:170:0) after 1m0s
[09:54:15.413] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:170:0)
[09:54:15.413] Timer tick, asking Buildbucket for the build status
[09:54:15.899] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:15.899] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:171:0) after 1m0s
[09:55:15.983] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:171:0)
[09:55:15.983] Timer tick, asking Buildbucket for the build status
[09:55:16.131] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:16.131] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:172:0) after 1m0s
[09:56:16.260] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:172:0)
[09:56:16.260] Timer tick, asking Buildbucket for the build status
[09:56:16.329] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:16.329] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:173:0) after 1m0s
[09:57:16.404] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:173:0)
[09:57:16.404] Timer tick, asking Buildbucket for the build status
[09:57:16.590] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:16.590] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:174:0) after 1m0s
[09:58:16.684] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:174:0)
[09:58:16.684] Timer tick, asking Buildbucket for the build status
[09:58:16.784] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:16.784] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:175:0) after 1m0s
[09:59:16.875] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:175:0)
[09:59:16.875] Timer tick, asking Buildbucket for the build status
[09:59:16.971] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:16.971] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:176:0) after 1m0s
[10:00:17.009] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:176:0)
[10:00:17.009] Timer tick, asking Buildbucket for the build status
[10:00:17.463] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:17.463] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:177:0) after 1m0s
[10:01:17.499] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:177:0)
[10:01:17.499] Timer tick, asking Buildbucket for the build status
[10:01:27.432] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:27.432] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:178:0) after 1m0s
[10:02:27.467] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:178:0)
[10:02:27.467] Timer tick, asking Buildbucket for the build status
[10:02:27.620] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:27.620] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:179:0) after 1m0s
[10:03:27.824] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:179:0)
[10:03:27.824] Timer tick, asking Buildbucket for the build status
[10:03:30.212] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:30.212] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:180:0) after 1m0s
[10:04:30.285] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:180:0)
[10:04:30.285] Timer tick, asking Buildbucket for the build status
[10:04:30.494] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:30.494] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:181:0) after 1m0s
[10:05:30.673] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:181:0)
[10:05:30.673] Timer tick, asking Buildbucket for the build status
[10:05:30.933] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:30.933] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:182:0) after 1m0s
[10:06:30.988] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:182:0)
[10:06:30.988] Timer tick, asking Buildbucket for the build status
[10:06:31.456] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:31.456] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:183:0) after 1m0s
[10:07:31.531] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:183:0)
[10:07:31.532] Timer tick, asking Buildbucket for the build status
[10:07:31.633] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:31.633] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:184:0) after 1m0s
[10:08:31.711] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:184:0)
[10:08:31.711] Timer tick, asking Buildbucket for the build status
[10:08:31.831] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:31.831] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:185:0) after 1m0s
[10:09:31.856] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:185:0)
[10:09:31.856] Timer tick, asking Buildbucket for the build status
[10:09:31.973] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:31.973] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:186:0) after 1m0s
[10:10:32.042] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:186:0)
[10:10:32.042] Timer tick, asking Buildbucket for the build status
[10:10:32.790] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:32.790] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:187:0) after 1m0s
[10:11:32.875] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:187:0)
[10:11:32.875] Timer tick, asking Buildbucket for the build status
[10:11:33.000] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:33.000] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:188:0) after 1m0s
[10:12:33.130] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:188:0)
[10:12:33.130] Timer tick, asking Buildbucket for the build status
[10:12:34.077] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:34.077] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:189:0) after 1m0s
[10:13:34.149] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:189:0)
[10:13:34.149] Timer tick, asking Buildbucket for the build status
[10:13:35.896] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:35.896] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:190:0) after 1m0s
[10:14:35.949] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:190:0)
[10:14:35.949] Timer tick, asking Buildbucket for the build status
[10:14:36.459] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:36.459] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:191:0) after 1m0s
[10:15:36.560] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:191:0)
[10:15:36.560] Timer tick, asking Buildbucket for the build status
[10:15:36.948] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:36.948] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:192:0) after 1m0s
[10:16:37.123] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:192:0)
[10:16:37.123] Timer tick, asking Buildbucket for the build status
[10:16:37.428] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:37.428] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:193:0) after 1m0s
[10:17:37.567] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:193:0)
[10:17:37.567] Timer tick, asking Buildbucket for the build status
[10:17:37.737] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:37.737] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:194:0) after 1m0s
[10:18:37.769] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:194:0)
[10:18:37.769] Timer tick, asking Buildbucket for the build status
[10:18:38.225] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:38.225] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:195:0) after 1m0s
[10:19:38.252] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:195:0)
[10:19:38.252] Timer tick, asking Buildbucket for the build status
[10:19:38.734] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:38.734] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:196:0) after 1m0s
[10:20:38.819] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:196:0)
[10:20:38.819] Timer tick, asking Buildbucket for the build status
[10:20:39.065] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:39.065] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:197:0) after 1m0s
[10:21:39.095] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:197:0)
[10:21:39.095] Timer tick, asking Buildbucket for the build status
[10:21:39.443] Build 8908520850212815696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:39.443] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9073950912558999728:198:0) after 1m0s
[10:22:13.275] Received PubSub notification, asking Buildbucket for the build status
[10:22:13.500] Build 8908520850212815696: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:22:13.500] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1562581329681985",
"created_by": "project:r8",
"created_ts": "1562569490190661",
"id": "8908520850212815696",
"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\": \"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\", \"title\": \"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\", \"url\": \"https://r8.googlesource.com/r8/+/0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"}}",
"project": "r8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://r8.googlesource.com/r8\", \"revision\": \"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\", \"title\": \"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\", \"url\": \"https://r8.googlesource.com/r8/+/0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"}]}, \"bot_id\": \"luci-r8-ci-internal-0-2ngu\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-internal\", \"buildnumber\": 383, \"internal\": \"True\", \"mastername\": \"internal.client.r8\", \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-r8-ci-internal-0-2ngu\"], \"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\": [\"4365-1559751\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1562569530258751",
"status": "COMPLETED",
"status_changed_ts": "1562581332004991",
"tags": [
"build_address:luci.r8.ci/linux-internal/383",
"builder:linux-internal",
"buildset:commit/git/0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/0f613d6095f4a7361ba0b91c8f5a42bc8de8d56a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073950912558999728",
"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/8908520850212815696/+/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:45e9382e02162a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1562581332192316",
"url": "https://ci.chromium.org/b/8908520850212815696",
"utcnow_ts": "1562581333473468"
}
}
[10:22:13.500] Invocation finished in 3h17m24.93131838s with status SUCCEEDED