[11:29:56.397] New invocation is queued and will start shortly
[11:29:57.542] Starting the invocation (attempt 1)
[11:29:57.590] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:29:57.590] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:29:57.590] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9080185422691956752",
"parameters_json": "{\"builder_name\":\"linux-internal\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"56d1a1c4a6465baba7bb889113997ebc5c929854\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-internal",
"scheduler_invocation_id:9080185422691956752",
"scheduler_job_id:r8/linux-internal",
"user_agent:luci-scheduler",
"buildset:commit/git/56d1a1c4a6465baba7bb889113997ebc5c929854",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/56d1a1c4a6465baba7bb889113997ebc5c929854",
"gitiles_ref:refs/heads/master"
]
}
[11:29:58.729] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "project:r8",
"created_ts": "1556623797759275",
"id": "8914755360599117440",
"parameters_json": "{\"builder_name\": \"linux-internal\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"56d1a1c4a6465baba7bb889113997ebc5c929854\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1556623798592978",
"tags": [
"build_address:luci.r8.ci/linux-internal/187",
"builder:linux-internal",
"buildset:commit/git/56d1a1c4a6465baba7bb889113997ebc5c929854",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/56d1a1c4a6465baba7bb889113997ebc5c929854",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080185422691956752",
"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/8914755360599117440/+/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": "1556623798593138",
"url": "https://ci.chromium.org/b/8914755360599117440",
"utcnow_ts": "1556623798720754"
}
}
[11:29:58.729] Task URL: https://ci.chromium.org/b/8914755360599117440
[11:29:58.729] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:2:0) after 1m0s
[11:30:58.762] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:2:0)
[11:30:58.762] Timer tick, asking Buildbucket for the build status
[11:30:58.868] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:30:58.868] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:3:0) after 1m0s
[11:31:58.874] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:3:0)
[11:31:58.874] Timer tick, asking Buildbucket for the build status
[11:31:58.977] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:31:58.977] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:4:0) after 1m0s
[11:32:58.995] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:4:0)
[11:32:58.995] Timer tick, asking Buildbucket for the build status
[11:32:59.063] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:32:59.063] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:5:0) after 1m0s
[11:33:59.037] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:5:0)
[11:33:59.038] Timer tick, asking Buildbucket for the build status
[11:33:59.110] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:33:59.110] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:6:0) after 1m0s
[11:34:59.083] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:6:0)
[11:34:59.083] Timer tick, asking Buildbucket for the build status
[11:34:59.241] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:34:59.241] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:7:0) after 1m0s
[11:35:59.271] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:7:0)
[11:35:59.271] Timer tick, asking Buildbucket for the build status
[11:35:59.526] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:35:59.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:8:0) after 1m0s
[11:36:59.513] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:8:0)
[11:36:59.513] Timer tick, asking Buildbucket for the build status
[11:36:59.982] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:36:59.982] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:9:0) after 1m0s
[11:37:59.988] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:9:0)
[11:37:59.988] Timer tick, asking Buildbucket for the build status
[11:38:00.100] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:38:00.100] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:10:0) after 1m0s
[11:39:00.096] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:10:0)
[11:39:00.096] Timer tick, asking Buildbucket for the build status
[11:39:00.156] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:39:00.156] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:11:0) after 1m0s
[11:40:00.146] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:11:0)
[11:40:00.146] Timer tick, asking Buildbucket for the build status
[11:40:00.286] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:40:00.286] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:12:0) after 1m0s
[11:41:00.306] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:12:0)
[11:41:00.306] Timer tick, asking Buildbucket for the build status
[11:41:00.366] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:41:00.367] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:13:0) after 1m0s
[11:42:00.388] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:13:0)
[11:42:00.388] Timer tick, asking Buildbucket for the build status
[11:42:00.883] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:42:00.883] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:14:0) after 1m0s
[11:43:00.922] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:14:0)
[11:43:00.922] Timer tick, asking Buildbucket for the build status
[11:43:01.189] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:43:01.189] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:15:0) after 1m0s
[11:44:01.209] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:15:0)
[11:44:01.209] Timer tick, asking Buildbucket for the build status
[11:44:01.392] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:44:01.392] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:16:0) after 1m0s
[11:45:01.383] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:16:0)
[11:45:01.383] Timer tick, asking Buildbucket for the build status
[11:45:02.060] Build 8914755360599117440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:45:02.060] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:17:0) after 1m0s
[11:45:17.166] Received PubSub notification, asking Buildbucket for the build status
[11:45:17.235] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:02.099] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:17:0)
[11:46:02.099] Timer tick, asking Buildbucket for the build status
[11:46:02.189] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:02.189] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:19:0) after 1m0s
[11:47:02.187] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:19:0)
[11:47:02.187] Timer tick, asking Buildbucket for the build status
[11:47:02.231] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:02.231] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:20:0) after 1m0s
[11:48:02.247] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:20:0)
[11:48:02.247] Timer tick, asking Buildbucket for the build status
[11:48:02.327] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:02.327] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:21:0) after 1m0s
[11:49:02.339] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:21:0)
[11:49:02.339] Timer tick, asking Buildbucket for the build status
[11:49:02.409] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:02.409] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:22:0) after 1m0s
[11:50:02.455] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:22:0)
[11:50:02.455] Timer tick, asking Buildbucket for the build status
[11:50:04.506] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:04.506] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:23:0) after 1m0s
[11:51:04.526] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:23:0)
[11:51:04.526] Timer tick, asking Buildbucket for the build status
[11:51:04.722] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:04.722] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:24:0) after 1m0s
[11:52:04.742] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:24:0)
[11:52:04.742] Timer tick, asking Buildbucket for the build status
[11:52:04.810] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:04.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:25:0) after 1m0s
[11:53:04.842] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:25:0)
[11:53:04.842] Timer tick, asking Buildbucket for the build status
[11:53:04.921] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:04.921] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:26:0) after 1m0s
[11:54:04.941] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:26:0)
[11:54:04.942] Timer tick, asking Buildbucket for the build status
[11:54:05.014] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:05.014] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:27:0) after 1m0s
[11:55:05.012] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:27:0)
[11:55:05.012] Timer tick, asking Buildbucket for the build status
[11:55:10.022] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:10.022] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:28:0) after 1m0s
[11:56:10.042] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:28:0)
[11:56:10.042] Timer tick, asking Buildbucket for the build status
[11:56:10.108] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:10.108] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:29:0) after 1m0s
[11:57:10.127] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:29:0)
[11:57:10.127] Timer tick, asking Buildbucket for the build status
[11:57:10.170] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:10.170] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:30:0) after 1m0s
[11:58:10.185] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:30:0)
[11:58:10.185] Timer tick, asking Buildbucket for the build status
[11:58:10.260] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:10.260] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:31:0) after 1m0s
[11:59:10.280] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:31:0)
[11:59:10.280] Timer tick, asking Buildbucket for the build status
[11:59:10.467] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:10.467] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:32:0) after 1m0s
[12:00:10.467] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:32:0)
[12:00:10.467] Timer tick, asking Buildbucket for the build status
[12:00:10.589] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:10.589] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:33:0) after 1m0s
[12:01:10.609] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:33:0)
[12:01:10.609] Timer tick, asking Buildbucket for the build status
[12:01:10.711] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:10.711] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:34:0) after 1m0s
[12:02:10.731] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:34:0)
[12:02:10.731] Timer tick, asking Buildbucket for the build status
[12:02:10.833] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:10.833] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:35:0) after 1m0s
[12:03:10.851] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:35:0)
[12:03:10.851] Timer tick, asking Buildbucket for the build status
[12:03:10.982] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:10.982] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:36:0) after 1m0s
[12:04:10.989] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:36:0)
[12:04:10.990] Timer tick, asking Buildbucket for the build status
[12:04:11.139] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:11.139] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:37:0) after 1m0s
[12:05:11.158] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:37:0)
[12:05:11.158] Timer tick, asking Buildbucket for the build status
[12:05:11.220] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:11.221] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:38:0) after 1m0s
[12:06:11.256] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:38:0)
[12:06:11.256] Timer tick, asking Buildbucket for the build status
[12:06:11.377] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:11.377] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:39:0) after 1m0s
[12:07:11.383] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:39:0)
[12:07:11.383] Timer tick, asking Buildbucket for the build status
[12:07:11.878] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:11.878] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:40:0) after 1m0s
[12:08:11.898] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:40:0)
[12:08:11.898] Timer tick, asking Buildbucket for the build status
[12:08:12.097] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:12.097] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:41:0) after 1m0s
[12:09:12.116] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:41:0)
[12:09:12.116] Timer tick, asking Buildbucket for the build status
[12:09:12.165] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:12.165] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:42:0) after 1m0s
[12:10:12.135] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:42:0)
[12:10:12.135] Timer tick, asking Buildbucket for the build status
[12:10:12.306] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:12.306] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:43:0) after 1m0s
[12:11:12.335] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:43:0)
[12:11:12.335] Timer tick, asking Buildbucket for the build status
[12:11:12.385] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:12.385] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:44:0) after 1m0s
[12:12:12.361] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:44:0)
[12:12:12.361] Timer tick, asking Buildbucket for the build status
[12:12:12.590] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:12.590] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:45:0) after 1m0s
[12:13:12.593] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:45:0)
[12:13:12.593] Timer tick, asking Buildbucket for the build status
[12:13:12.862] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:12.862] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:46:0) after 1m0s
[12:14:12.899] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:46:0)
[12:14:12.899] Timer tick, asking Buildbucket for the build status
[12:14:12.952] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:12.952] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:47:0) after 1m0s
[12:15:12.950] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:47:0)
[12:15:12.950] Timer tick, asking Buildbucket for the build status
[12:15:13.185] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:13.185] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:48:0) after 1m0s
[12:16:13.205] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:48:0)
[12:16:13.205] Timer tick, asking Buildbucket for the build status
[12:16:13.341] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:13.341] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:49:0) after 1m0s
[12:17:13.332] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:49:0)
[12:17:13.332] Timer tick, asking Buildbucket for the build status
[12:17:13.403] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:13.403] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:50:0) after 1m0s
[12:18:13.460] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:50:0)
[12:18:13.460] Timer tick, asking Buildbucket for the build status
[12:18:13.523] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:13.523] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:51:0) after 1m0s
[12:19:13.557] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:51:0)
[12:19:13.557] Timer tick, asking Buildbucket for the build status
[12:19:13.660] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:13.660] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:52:0) after 1m0s
[12:20:13.690] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:52:0)
[12:20:13.690] Timer tick, asking Buildbucket for the build status
[12:20:13.778] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:13.778] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:53:0) after 1m0s
[12:21:13.802] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:53:0)
[12:21:13.802] Timer tick, asking Buildbucket for the build status
[12:21:13.881] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:13.881] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:54:0) after 1m0s
[12:22:13.963] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:54:0)
[12:22:13.963] Timer tick, asking Buildbucket for the build status
[12:22:14.033] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:14.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:55:0) after 1m0s
[12:23:14.051] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:55:0)
[12:23:14.051] Timer tick, asking Buildbucket for the build status
[12:23:14.250] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:14.250] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:56:0) after 1m0s
[12:24:14.252] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:56:0)
[12:24:14.252] Timer tick, asking Buildbucket for the build status
[12:24:14.313] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:14.313] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:57:0) after 1m0s
[12:25:14.350] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:57:0)
[12:25:14.350] Timer tick, asking Buildbucket for the build status
[12:25:14.390] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:14.390] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:58:0) after 1m0s
[12:26:14.412] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:58:0)
[12:26:14.412] Timer tick, asking Buildbucket for the build status
[12:26:15.287] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:15.287] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:59:0) after 1m0s
[12:27:15.288] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:59:0)
[12:27:15.288] Timer tick, asking Buildbucket for the build status
[12:27:15.400] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:15.400] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:60:0) after 1m0s
[12:28:15.460] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:60:0)
[12:28:15.460] Timer tick, asking Buildbucket for the build status
[12:28:15.569] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:15.569] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:61:0) after 1m0s
[12:29:15.585] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:61:0)
[12:29:15.585] Timer tick, asking Buildbucket for the build status
[12:29:15.645] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:15.645] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:62:0) after 1m0s
[12:30:15.676] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:62:0)
[12:30:15.676] Timer tick, asking Buildbucket for the build status
[12:30:15.795] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:15.795] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:63:0) after 1m0s
[12:31:15.790] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:63:0)
[12:31:15.790] Timer tick, asking Buildbucket for the build status
[12:31:16.074] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:16.074] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:64:0) after 1m0s
[12:32:16.093] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:64:0)
[12:32:16.093] Timer tick, asking Buildbucket for the build status
[12:32:16.197] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:16.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:65:0) after 1m0s
[12:33:16.181] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:65:0)
[12:33:16.181] Timer tick, asking Buildbucket for the build status
[12:33:16.370] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:16.370] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:66:0) after 1m0s
[12:34:16.346] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:66:0)
[12:34:16.346] Timer tick, asking Buildbucket for the build status
[12:34:16.437] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:16.437] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:67:0) after 1m0s
[12:35:16.466] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:67:0)
[12:35:16.466] Timer tick, asking Buildbucket for the build status
[12:35:16.580] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:16.580] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:68:0) after 1m0s
[12:36:16.601] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:68:0)
[12:36:16.601] Timer tick, asking Buildbucket for the build status
[12:36:16.654] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:16.654] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:69:0) after 1m0s
[12:37:16.635] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:69:0)
[12:37:16.636] Timer tick, asking Buildbucket for the build status
[12:37:16.880] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:16.880] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:70:0) after 1m0s
[12:38:16.895] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:70:0)
[12:38:16.895] Timer tick, asking Buildbucket for the build status
[12:38:16.999] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:16.999] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:71:0) after 1m0s
[12:39:17.038] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:71:0)
[12:39:17.038] Timer tick, asking Buildbucket for the build status
[12:39:17.075] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:17.075] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:72:0) after 1m0s
[12:40:17.095] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:72:0)
[12:40:17.095] Timer tick, asking Buildbucket for the build status
[12:40:17.192] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:17.192] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:73:0) after 1m0s
[12:41:17.202] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:73:0)
[12:41:17.202] Timer tick, asking Buildbucket for the build status
[12:41:17.274] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:17.274] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:74:0) after 1m0s
[12:42:17.275] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:74:0)
[12:42:17.275] Timer tick, asking Buildbucket for the build status
[12:42:17.332] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:17.332] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:75:0) after 1m0s
[12:43:17.342] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:75:0)
[12:43:17.342] Timer tick, asking Buildbucket for the build status
[12:43:17.620] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:17.620] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:76:0) after 1m0s
[12:44:17.657] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:76:0)
[12:44:17.657] Timer tick, asking Buildbucket for the build status
[12:44:17.759] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:17.759] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:77:0) after 1m0s
[12:45:17.758] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:77:0)
[12:45:17.758] Timer tick, asking Buildbucket for the build status
[12:45:18.033] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:18.033] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:78:0) after 1m0s
[12:46:18.122] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:78:0)
[12:46:18.122] Timer tick, asking Buildbucket for the build status
[12:46:18.253] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:18.253] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:79:0) after 1m0s
[12:47:18.283] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:79:0)
[12:47:18.283] Timer tick, asking Buildbucket for the build status
[12:47:18.336] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:18.336] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:80:0) after 1m0s
[12:48:18.344] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:80:0)
[12:48:18.344] Timer tick, asking Buildbucket for the build status
[12:48:18.498] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:18.498] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:81:0) after 1m0s
[12:49:18.526] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:81:0)
[12:49:18.526] Timer tick, asking Buildbucket for the build status
[12:49:18.969] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:18.969] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:82:0) after 1m0s
[12:50:18.989] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:82:0)
[12:50:18.989] Timer tick, asking Buildbucket for the build status
[12:50:19.055] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:19.055] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:83:0) after 1m0s
[12:51:19.075] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:83:0)
[12:51:19.075] Timer tick, asking Buildbucket for the build status
[12:51:19.195] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:19.195] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:84:0) after 1m0s
[12:52:19.224] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:84:0)
[12:52:19.224] Timer tick, asking Buildbucket for the build status
[12:52:19.288] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:19.288] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:85:0) after 1m0s
[12:53:19.413] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:85:0)
[12:53:19.413] Timer tick, asking Buildbucket for the build status
[12:53:19.481] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:19.481] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:86:0) after 1m0s
[12:54:19.502] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:86:0)
[12:54:19.502] Timer tick, asking Buildbucket for the build status
[12:54:19.555] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:19.555] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:87:0) after 1m0s
[12:55:19.577] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:87:0)
[12:55:19.577] Timer tick, asking Buildbucket for the build status
[12:55:19.645] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:19.645] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:88:0) after 1m0s
[12:56:19.675] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:88:0)
[12:56:19.675] Timer tick, asking Buildbucket for the build status
[12:56:19.745] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:19.745] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:89:0) after 1m0s
[12:57:19.749] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:89:0)
[12:57:19.749] Timer tick, asking Buildbucket for the build status
[12:57:19.825] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:19.825] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:90:0) after 1m0s
[12:58:19.883] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:90:0)
[12:58:19.883] Timer tick, asking Buildbucket for the build status
[12:58:20.022] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:20.022] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:91:0) after 1m0s
[12:59:20.048] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:91:0)
[12:59:20.048] Timer tick, asking Buildbucket for the build status
[12:59:20.191] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:20.191] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:92:0) after 1m0s
[13:00:20.224] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:92:0)
[13:00:20.224] Timer tick, asking Buildbucket for the build status
[13:00:20.272] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:20.272] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:93:0) after 1m0s
[13:01:20.326] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:93:0)
[13:01:20.326] Timer tick, asking Buildbucket for the build status
[13:01:20.428] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:20.428] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:94:0) after 1m0s
[13:02:20.424] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:94:0)
[13:02:20.424] Timer tick, asking Buildbucket for the build status
[13:02:20.586] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:20.586] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:95:0) after 1m0s
[13:03:20.606] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:95:0)
[13:03:20.606] Timer tick, asking Buildbucket for the build status
[13:03:20.675] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:20.675] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:96:0) after 1m0s
[13:04:20.692] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:96:0)
[13:04:20.692] Timer tick, asking Buildbucket for the build status
[13:04:20.803] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:20.803] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:97:0) after 1m0s
[13:05:20.863] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:97:0)
[13:05:20.863] Timer tick, asking Buildbucket for the build status
[13:05:20.971] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:20.971] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:98:0) after 1m0s
[13:06:20.990] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:98:0)
[13:06:20.990] Timer tick, asking Buildbucket for the build status
[13:06:21.210] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:21.211] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:99:0) after 1m0s
[13:07:21.230] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:99:0)
[13:07:21.230] Timer tick, asking Buildbucket for the build status
[13:07:21.285] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:21.285] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:100:0) after 1m0s
[13:08:21.357] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:100:0)
[13:08:21.357] Timer tick, asking Buildbucket for the build status
[13:08:21.811] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:21.811] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:101:0) after 1m0s
[13:09:21.808] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:101:0)
[13:09:21.808] Timer tick, asking Buildbucket for the build status
[13:09:22.172] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:22.172] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:102:0) after 1m0s
[13:10:22.198] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:102:0)
[13:10:22.198] Timer tick, asking Buildbucket for the build status
[13:10:22.249] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:22.249] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:103:0) after 1m0s
[13:11:22.234] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:103:0)
[13:11:22.234] Timer tick, asking Buildbucket for the build status
[13:11:22.337] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:22.337] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:104:0) after 1m0s
[13:12:22.331] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:104:0)
[13:12:22.331] Timer tick, asking Buildbucket for the build status
[13:12:22.443] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:22.443] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:105:0) after 1m0s
[13:13:22.447] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:105:0)
[13:13:22.447] Timer tick, asking Buildbucket for the build status
[13:13:22.527] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:22.527] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:106:0) after 1m0s
[13:14:22.529] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:106:0)
[13:14:22.529] Timer tick, asking Buildbucket for the build status
[13:14:22.569] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:22.569] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:107:0) after 1m0s
[13:15:22.618] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:107:0)
[13:15:22.618] Timer tick, asking Buildbucket for the build status
[13:15:22.681] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:22.681] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:108:0) after 1m0s
[13:16:22.694] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:108:0)
[13:16:22.694] Timer tick, asking Buildbucket for the build status
[13:16:22.757] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:22.757] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:109:0) after 1m0s
[13:17:22.784] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:109:0)
[13:17:22.784] Timer tick, asking Buildbucket for the build status
[13:17:22.839] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:22.839] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:110:0) after 1m0s
[13:18:22.861] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:110:0)
[13:18:22.861] Timer tick, asking Buildbucket for the build status
[13:18:22.910] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:22.910] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:111:0) after 1m0s
[13:19:22.931] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:111:0)
[13:19:22.931] Timer tick, asking Buildbucket for the build status
[13:19:23.195] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:23.195] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:112:0) after 1m0s
[13:20:23.223] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:112:0)
[13:20:23.223] Timer tick, asking Buildbucket for the build status
[13:20:23.293] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:23.293] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:113:0) after 1m0s
[13:21:23.313] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:113:0)
[13:21:23.313] Timer tick, asking Buildbucket for the build status
[13:21:23.444] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:23.444] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:114:0) after 1m0s
[13:22:23.501] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:114:0)
[13:22:23.501] Timer tick, asking Buildbucket for the build status
[13:22:23.672] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:23.672] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:115:0) after 1m0s
[13:23:23.704] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:115:0)
[13:23:23.704] Timer tick, asking Buildbucket for the build status
[13:23:23.846] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:23.846] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:116:0) after 1m0s
[13:24:23.868] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:116:0)
[13:24:23.868] Timer tick, asking Buildbucket for the build status
[13:24:23.909] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:23.909] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:117:0) after 1m0s
[13:25:23.930] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:117:0)
[13:25:23.930] Timer tick, asking Buildbucket for the build status
[13:25:23.993] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:23.993] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:118:0) after 1m0s
[13:26:23.980] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:118:0)
[13:26:23.980] Timer tick, asking Buildbucket for the build status
[13:26:24.042] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:24.042] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:119:0) after 1m0s
[13:27:24.062] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:119:0)
[13:27:24.062] Timer tick, asking Buildbucket for the build status
[13:27:24.127] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:24.127] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:120:0) after 1m0s
[13:28:24.159] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:120:0)
[13:28:24.159] Timer tick, asking Buildbucket for the build status
[13:28:24.299] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:24.299] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:121:0) after 1m0s
[13:29:24.275] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:121:0)
[13:29:24.275] Timer tick, asking Buildbucket for the build status
[13:29:24.464] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:24.464] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:122:0) after 1m0s
[13:30:24.549] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:122:0)
[13:30:24.549] Timer tick, asking Buildbucket for the build status
[13:30:24.809] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:24.809] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:123:0) after 1m0s
[13:31:24.834] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:123:0)
[13:31:24.834] Timer tick, asking Buildbucket for the build status
[13:31:24.953] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:24.953] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:124:0) after 1m0s
[13:32:24.988] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:124:0)
[13:32:24.988] Timer tick, asking Buildbucket for the build status
[13:32:25.031] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:25.031] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:125:0) after 1m0s
[13:33:25.052] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:125:0)
[13:33:25.052] Timer tick, asking Buildbucket for the build status
[13:33:25.250] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:25.250] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:126:0) after 1m0s
[13:34:25.276] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:126:0)
[13:34:25.276] Timer tick, asking Buildbucket for the build status
[13:34:25.342] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:25.342] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:127:0) after 1m0s
[13:35:25.339] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:127:0)
[13:35:25.339] Timer tick, asking Buildbucket for the build status
[13:35:25.401] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:25.401] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:128:0) after 1m0s
[13:36:25.416] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:128:0)
[13:36:25.416] Timer tick, asking Buildbucket for the build status
[13:36:25.506] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:25.506] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:129:0) after 1m0s
[13:37:25.497] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:129:0)
[13:37:25.497] Timer tick, asking Buildbucket for the build status
[13:37:25.547] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:25.547] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:130:0) after 1m0s
[13:38:25.570] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:130:0)
[13:38:25.570] Timer tick, asking Buildbucket for the build status
[13:38:25.638] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:25.638] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:131:0) after 1m0s
[13:39:25.613] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:131:0)
[13:39:25.613] Timer tick, asking Buildbucket for the build status
[13:39:25.763] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:25.763] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:132:0) after 1m0s
[13:40:25.785] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:132:0)
[13:40:25.785] Timer tick, asking Buildbucket for the build status
[13:40:25.863] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:25.863] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:133:0) after 1m0s
[13:41:25.883] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:133:0)
[13:41:25.883] Timer tick, asking Buildbucket for the build status
[13:41:26.038] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:26.038] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:134:0) after 1m0s
[13:42:26.067] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:134:0)
[13:42:26.067] Timer tick, asking Buildbucket for the build status
[13:42:26.174] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:26.174] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:135:0) after 1m0s
[13:43:26.153] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:135:0)
[13:43:26.153] Timer tick, asking Buildbucket for the build status
[13:43:26.221] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:26.221] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:136:0) after 1m0s
[13:44:26.243] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:136:0)
[13:44:26.243] Timer tick, asking Buildbucket for the build status
[13:44:26.306] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:26.306] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:137:0) after 1m0s
[13:45:26.298] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:137:0)
[13:45:26.298] Timer tick, asking Buildbucket for the build status
[13:45:26.354] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:26.354] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:138:0) after 1m0s
[13:46:26.345] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:138:0)
[13:46:26.345] Timer tick, asking Buildbucket for the build status
[13:46:26.424] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:26.424] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:139:0) after 1m0s
[13:47:26.448] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:139:0)
[13:47:26.448] Timer tick, asking Buildbucket for the build status
[13:47:26.526] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:26.526] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:140:0) after 1m0s
[13:48:26.535] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:140:0)
[13:48:26.535] Timer tick, asking Buildbucket for the build status
[13:48:26.586] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:26.586] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:141:0) after 1m0s
[13:49:26.569] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:141:0)
[13:49:26.569] Timer tick, asking Buildbucket for the build status
[13:49:26.625] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:26.625] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:142:0) after 1m0s
[13:50:26.656] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:142:0)
[13:50:26.656] Timer tick, asking Buildbucket for the build status
[13:50:26.703] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:26.703] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:143:0) after 1m0s
[13:51:26.734] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:143:0)
[13:51:26.734] Timer tick, asking Buildbucket for the build status
[13:51:26.837] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:26.837] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:144:0) after 1m0s
[13:52:26.858] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:144:0)
[13:52:26.858] Timer tick, asking Buildbucket for the build status
[13:52:26.985] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:26.985] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:145:0) after 1m0s
[13:53:27.012] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:145:0)
[13:53:27.012] Timer tick, asking Buildbucket for the build status
[13:53:27.087] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:27.087] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:146:0) after 1m0s
[13:54:27.125] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:146:0)
[13:54:27.125] Timer tick, asking Buildbucket for the build status
[13:54:27.167] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:27.167] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:147:0) after 1m0s
[13:55:27.209] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:147:0)
[13:55:27.209] Timer tick, asking Buildbucket for the build status
[13:55:27.289] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:27.289] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:148:0) after 1m0s
[13:56:27.310] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:148:0)
[13:56:27.310] Timer tick, asking Buildbucket for the build status
[13:56:27.518] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:27.518] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:149:0) after 1m0s
[13:57:27.515] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:149:0)
[13:57:27.515] Timer tick, asking Buildbucket for the build status
[13:57:27.604] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:27.604] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:150:0) after 1m0s
[13:58:27.628] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:150:0)
[13:58:27.628] Timer tick, asking Buildbucket for the build status
[13:58:27.796] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:27.796] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:151:0) after 1m0s
[13:59:27.833] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:151:0)
[13:59:27.833] Timer tick, asking Buildbucket for the build status
[13:59:27.889] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:27.889] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:152:0) after 1m0s
[14:00:27.894] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:152:0)
[14:00:27.894] Timer tick, asking Buildbucket for the build status
[14:00:27.949] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:27.949] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:153:0) after 1m0s
[14:01:27.978] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:153:0)
[14:01:27.978] Timer tick, asking Buildbucket for the build status
[14:01:28.182] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:28.182] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:154:0) after 1m0s
[14:02:28.205] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:154:0)
[14:02:28.205] Timer tick, asking Buildbucket for the build status
[14:02:28.241] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:28.241] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:155:0) after 1m0s
[14:03:28.282] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:155:0)
[14:03:28.282] Timer tick, asking Buildbucket for the build status
[14:03:28.349] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:28.349] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:156:0) after 1m0s
[14:04:28.386] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:156:0)
[14:04:28.386] Timer tick, asking Buildbucket for the build status
[14:04:28.430] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:28.430] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:157:0) after 1m0s
[14:05:28.471] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:157:0)
[14:05:28.471] Timer tick, asking Buildbucket for the build status
[14:05:28.799] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:28.799] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:158:0) after 1m0s
[14:06:28.828] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:158:0)
[14:06:28.828] Timer tick, asking Buildbucket for the build status
[14:06:28.881] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:28.881] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:159:0) after 1m0s
[14:07:28.909] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:159:0)
[14:07:28.909] Timer tick, asking Buildbucket for the build status
[14:07:29.026] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:29.026] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:160:0) after 1m0s
[14:08:29.074] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:160:0)
[14:08:29.074] Timer tick, asking Buildbucket for the build status
[14:08:29.142] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:29.142] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:161:0) after 1m0s
[14:09:29.163] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:161:0)
[14:09:29.163] Timer tick, asking Buildbucket for the build status
[14:09:29.303] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:29.303] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:162:0) after 1m0s
[14:10:29.302] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:162:0)
[14:10:29.302] Timer tick, asking Buildbucket for the build status
[14:10:29.413] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:29.413] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:163:0) after 1m0s
[14:11:29.398] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:163:0)
[14:11:29.398] Timer tick, asking Buildbucket for the build status
[14:11:29.455] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:29.455] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:164:0) after 1m0s
[14:12:29.477] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:164:0)
[14:12:29.477] Timer tick, asking Buildbucket for the build status
[14:12:29.781] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:29.782] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:165:0) after 1m0s
[14:13:29.801] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:165:0)
[14:13:29.801] Timer tick, asking Buildbucket for the build status
[14:13:30.074] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:30.074] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:166:0) after 1m0s
[14:14:30.109] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:166:0)
[14:14:30.109] Timer tick, asking Buildbucket for the build status
[14:14:30.291] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:30.291] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:167:0) after 1m0s
[14:15:30.313] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:167:0)
[14:15:30.313] Timer tick, asking Buildbucket for the build status
[14:15:30.369] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:30.369] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:168:0) after 1m0s
[14:16:30.372] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:168:0)
[14:16:30.372] Timer tick, asking Buildbucket for the build status
[14:16:30.518] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:30.518] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:169:0) after 1m0s
[14:17:30.540] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:169:0)
[14:17:30.540] Timer tick, asking Buildbucket for the build status
[14:17:30.630] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:30.630] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:170:0) after 1m0s
[14:18:30.645] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:170:0)
[14:18:30.645] Timer tick, asking Buildbucket for the build status
[14:18:30.772] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:30.772] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:171:0) after 1m0s
[14:19:30.805] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:171:0)
[14:19:30.805] Timer tick, asking Buildbucket for the build status
[14:19:30.912] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:30.913] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:172:0) after 1m0s
[14:20:31.055] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:172:0)
[14:20:31.055] Timer tick, asking Buildbucket for the build status
[14:20:31.098] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:31.098] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:173:0) after 1m0s
[14:21:31.123] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:173:0)
[14:21:31.123] Timer tick, asking Buildbucket for the build status
[14:21:31.197] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:31.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:174:0) after 1m0s
[14:22:31.233] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:174:0)
[14:22:31.233] Timer tick, asking Buildbucket for the build status
[14:22:31.269] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:31.269] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:175:0) after 1m0s
[14:23:31.292] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:175:0)
[14:23:31.292] Timer tick, asking Buildbucket for the build status
[14:23:31.427] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:31.427] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:176:0) after 1m0s
[14:24:31.407] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:176:0)
[14:24:31.407] Timer tick, asking Buildbucket for the build status
[14:24:31.535] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:31.535] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:177:0) after 1m0s
[14:25:31.555] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:177:0)
[14:25:31.555] Timer tick, asking Buildbucket for the build status
[14:25:31.632] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:31.632] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:178:0) after 1m0s
[14:26:31.611] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:178:0)
[14:26:31.611] Timer tick, asking Buildbucket for the build status
[14:26:31.655] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:31.655] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:179:0) after 1m0s
[14:27:31.679] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:179:0)
[14:27:31.679] Timer tick, asking Buildbucket for the build status
[14:27:31.861] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:31.861] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:180:0) after 1m0s
[14:28:31.885] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:180:0)
[14:28:31.885] Timer tick, asking Buildbucket for the build status
[14:28:31.990] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:31.990] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:181:0) after 1m0s
[14:29:31.981] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:181:0)
[14:29:31.981] Timer tick, asking Buildbucket for the build status
[14:29:32.092] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:32.092] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:182:0) after 1m0s
[14:30:32.124] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:182:0)
[14:30:32.124] Timer tick, asking Buildbucket for the build status
[14:30:32.197] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:32.197] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:183:0) after 1m0s
[14:31:32.226] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:183:0)
[14:31:32.226] Timer tick, asking Buildbucket for the build status
[14:31:32.302] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:32.302] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:184:0) after 1m0s
[14:32:32.325] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:184:0)
[14:32:32.325] Timer tick, asking Buildbucket for the build status
[14:32:32.374] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:32.374] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:185:0) after 1m0s
[14:33:32.406] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:185:0)
[14:33:32.406] Timer tick, asking Buildbucket for the build status
[14:33:33.006] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:33.006] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:186:0) after 1m0s
[14:34:33.083] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:186:0)
[14:34:33.083] Timer tick, asking Buildbucket for the build status
[14:34:33.127] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:33.127] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:187:0) after 1m0s
[14:35:33.103] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:187:0)
[14:35:33.103] Timer tick, asking Buildbucket for the build status
[14:35:33.181] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:33.181] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:188:0) after 1m0s
[14:36:33.189] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:188:0)
[14:36:33.189] Timer tick, asking Buildbucket for the build status
[14:36:33.228] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:33.228] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:189:0) after 1m0s
[14:37:33.252] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:189:0)
[14:37:33.252] Timer tick, asking Buildbucket for the build status
[14:37:33.295] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:33.295] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:190:0) after 1m0s
[14:38:33.272] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:190:0)
[14:38:33.272] Timer tick, asking Buildbucket for the build status
[14:38:33.543] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:33.543] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:191:0) after 1m0s
[14:39:33.571] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:191:0)
[14:39:33.571] Timer tick, asking Buildbucket for the build status
[14:39:33.676] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:33.676] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:192:0) after 1m0s
[14:40:33.700] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:192:0)
[14:40:33.700] Timer tick, asking Buildbucket for the build status
[14:40:33.907] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:33.907] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:193:0) after 1m0s
[14:41:33.939] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:193:0)
[14:41:33.939] Timer tick, asking Buildbucket for the build status
[14:41:33.989] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:33.989] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:194:0) after 1m0s
[14:42:33.975] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:194:0)
[14:42:33.975] Timer tick, asking Buildbucket for the build status
[14:42:34.187] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:34.187] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:195:0) after 1m0s
[14:43:34.181] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:195:0)
[14:43:34.181] Timer tick, asking Buildbucket for the build status
[14:43:34.323] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:34.323] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:196:0) after 1m0s
[14:44:34.358] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:196:0)
[14:44:34.358] Timer tick, asking Buildbucket for the build status
[14:44:34.555] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:34.555] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:197:0) after 1m0s
[14:45:34.578] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:197:0)
[14:45:34.578] Timer tick, asking Buildbucket for the build status
[14:45:34.638] Build 8914755360599117440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:34.638] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9080185422691956752:198:0) after 1m0s
[14:46:13.065] Received PubSub notification, asking Buildbucket for the build status
[14:46:13.250] Build 8914755360599117440: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:46:13.250] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1556635571095526",
"created_by": "project:r8",
"created_ts": "1556623797759275",
"id": "8914755360599117440",
"parameters_json": "{\"builder_name\": \"linux-internal\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"56d1a1c4a6465baba7bb889113997ebc5c929854\"}}",
"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-r4rp\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-internal\", \"buildnumber\": 187, \"internal\": \"True\", \"mastername\": \"internal.client.r8\", \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"56d1a1c4a6465baba7bb889113997ebc5c929854\"}, \"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-r4rp\"], \"image\": [\"chrome-xenial-19041001-3b730ae8765\"], \"inside_docker\": [\"0\"], \"internal\": [\"true\"], \"kvm\": [\"0\"], \"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\": [\"4277-e1590cf\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1556624716348286",
"status": "COMPLETED",
"status_changed_ts": "1556635572417741",
"tags": [
"build_address:luci.r8.ci/linux-internal/187",
"builder:linux-internal",
"buildset:commit/git/56d1a1c4a6465baba7bb889113997ebc5c929854",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/56d1a1c4a6465baba7bb889113997ebc5c929854",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080185422691956752",
"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/8914755360599117440/+/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:4486d3ba3408dc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1556635572421444",
"url": "https://ci.chromium.org/b/8914755360599117440",
"utcnow_ts": "1556635573233507"
}
}
[14:46:13.250] Invocation finished in 3h16m16.870352349s with status SUCCEEDED