[12:14:12.746] New invocation is queued and will start shortly
[12:14:14.062] Starting the invocation (attempt 1)
[12:14:14.114] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:14:14.114] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:14:14.115] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9074022043593667008",
"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\":\"d31722aab5b3f51eeed7410449d28ee7786c0ae1\"},\"id\":\"https://r8.googlesource.com/r8/+/refs/heads/master@d31722aab5b3f51eeed7410449d28ee7786c0ae1\",\"title\":\"d31722aab5b3f51eeed7410449d28ee7786c0ae1\",\"url\":\"https://r8.googlesource.com/r8/+/d31722aab5b3f51eeed7410449d28ee7786c0ae1\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"d31722aab5b3f51eeed7410449d28ee7786c0ae1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-internal",
"scheduler_invocation_id:9074022043593667008",
"scheduler_job_id:r8/linux-internal",
"user_agent:luci-scheduler",
"buildset:commit/git/d31722aab5b3f51eeed7410449d28ee7786c0ae1",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/d31722aab5b3f51eeed7410449d28ee7786c0ae1",
"gitiles_ref:refs/heads/master"
]
}
[12:14:15.188] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"created_by": "project:r8",
"created_ts": "1562501654228701",
"id": "8908591981374077664",
"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\": \"d31722aab5b3f51eeed7410449d28ee7786c0ae1\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@d31722aab5b3f51eeed7410449d28ee7786c0ae1\", \"title\": \"d31722aab5b3f51eeed7410449d28ee7786c0ae1\", \"url\": \"https://r8.googlesource.com/r8/+/d31722aab5b3f51eeed7410449d28ee7786c0ae1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"d31722aab5b3f51eeed7410449d28ee7786c0ae1\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1562501654946029",
"tags": [
"build_address:luci.r8.ci/linux-internal/381",
"builder:linux-internal",
"buildset:commit/git/d31722aab5b3f51eeed7410449d28ee7786c0ae1",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/d31722aab5b3f51eeed7410449d28ee7786c0ae1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074022043593667008",
"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/8908591981374077664/+/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": "1562501654946121",
"url": "https://ci.chromium.org/b/8908591981374077664",
"utcnow_ts": "1562501655172985"
}
}
[12:14:15.188] Task URL: https://ci.chromium.org/b/8908591981374077664
[12:14:15.188] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:2:0) after 1m0s
[12:14:46.545] Received PubSub notification, asking Buildbucket for the build status
[12:14:46.629] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:15.311] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:2:0)
[12:15:15.311] Timer tick, asking Buildbucket for the build status
[12:15:15.429] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:15.429] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:4:0) after 1m0s
[12:16:15.575] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:4:0)
[12:16:15.575] Timer tick, asking Buildbucket for the build status
[12:16:15.681] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:15.681] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:5:0) after 1m0s
[12:17:15.701] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:5:0)
[12:17:15.701] Timer tick, asking Buildbucket for the build status
[12:17:15.851] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:15.851] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:6:0) after 1m0s
[12:18:15.902] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:6:0)
[12:18:15.902] Timer tick, asking Buildbucket for the build status
[12:18:16.059] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:16.059] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:7:0) after 1m0s
[12:19:16.113] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:7:0)
[12:19:16.113] Timer tick, asking Buildbucket for the build status
[12:19:16.462] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:16.462] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:8:0) after 1m0s
[12:20:16.652] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:8:0)
[12:20:16.652] Timer tick, asking Buildbucket for the build status
[12:20:17.296] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:17.296] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:9:0) after 1m0s
[12:21:17.317] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:9:0)
[12:21:17.317] Timer tick, asking Buildbucket for the build status
[12:21:17.397] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:17.397] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:10:0) after 1m0s
[12:22:17.423] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:10:0)
[12:22:17.423] Timer tick, asking Buildbucket for the build status
[12:22:17.739] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:17.739] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:11:0) after 1m0s
[12:23:17.765] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:11:0)
[12:23:17.765] Timer tick, asking Buildbucket for the build status
[12:23:18.008] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:18.008] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:12:0) after 1m0s
[12:24:18.034] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:12:0)
[12:24:18.034] Timer tick, asking Buildbucket for the build status
[12:24:18.131] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:18.132] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:13:0) after 1m0s
[12:25:18.244] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:13:0)
[12:25:18.244] Timer tick, asking Buildbucket for the build status
[12:25:18.403] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:18.403] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:14:0) after 1m0s
[12:26:18.508] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:14:0)
[12:26:18.508] Timer tick, asking Buildbucket for the build status
[12:26:18.699] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:18.699] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:15:0) after 1m0s
[12:27:18.729] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:15:0)
[12:27:18.729] Timer tick, asking Buildbucket for the build status
[12:27:18.931] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:18.931] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:16:0) after 1m0s
[12:28:18.970] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:16:0)
[12:28:18.970] Timer tick, asking Buildbucket for the build status
[12:28:19.137] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:19.138] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:17:0) after 1m0s
[12:29:19.298] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:17:0)
[12:29:19.298] Timer tick, asking Buildbucket for the build status
[12:29:19.369] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:19.369] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:18:0) after 1m0s
[12:30:19.399] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:18:0)
[12:30:19.399] Timer tick, asking Buildbucket for the build status
[12:30:19.715] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:19.715] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:19:0) after 1m0s
[12:31:19.855] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:19:0)
[12:31:19.855] Timer tick, asking Buildbucket for the build status
[12:31:23.022] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:23.022] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:20:0) after 1m0s
[12:32:23.226] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:20:0)
[12:32:23.226] Timer tick, asking Buildbucket for the build status
[12:32:23.609] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:23.609] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:21:0) after 1m0s
[12:33:23.737] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:21:0)
[12:33:23.737] Timer tick, asking Buildbucket for the build status
[12:33:23.882] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:23.882] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:22:0) after 1m0s
[12:34:24.001] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:22:0)
[12:34:24.001] Timer tick, asking Buildbucket for the build status
[12:34:24.313] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:24.313] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:23:0) after 1m0s
[12:35:24.339] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:23:0)
[12:35:24.339] Timer tick, asking Buildbucket for the build status
[12:35:24.671] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:24.671] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:24:0) after 1m0s
[12:36:24.703] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:24:0)
[12:36:24.703] Timer tick, asking Buildbucket for the build status
[12:36:24.798] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:24.798] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:25:0) after 1m0s
[12:37:25.128] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:25:0)
[12:37:25.128] Timer tick, asking Buildbucket for the build status
[12:37:25.246] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:25.246] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:26:0) after 1m0s
[12:38:25.403] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:26:0)
[12:38:25.403] Timer tick, asking Buildbucket for the build status
[12:38:25.680] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:25.680] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:27:0) after 1m0s
[12:39:25.710] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:27:0)
[12:39:25.710] Timer tick, asking Buildbucket for the build status
[12:39:25.797] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:25.797] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:28:0) after 1m0s
[12:40:25.872] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:28:0)
[12:40:25.872] Timer tick, asking Buildbucket for the build status
[12:40:25.972] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:25.972] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:29:0) after 1m0s
[12:41:26.004] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:29:0)
[12:41:26.004] Timer tick, asking Buildbucket for the build status
[12:41:26.132] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:26.132] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:30:0) after 1m0s
[12:42:26.152] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:30:0)
[12:42:26.153] Timer tick, asking Buildbucket for the build status
[12:42:26.852] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:26.852] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:31:0) after 1m0s
[12:43:27.022] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:31:0)
[12:43:27.022] Timer tick, asking Buildbucket for the build status
[12:43:27.220] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:27.221] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:32:0) after 1m0s
[12:44:27.365] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:32:0)
[12:44:27.365] Timer tick, asking Buildbucket for the build status
[12:44:27.624] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:27.624] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:33:0) after 1m0s
[12:45:27.751] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:33:0)
[12:45:27.751] Timer tick, asking Buildbucket for the build status
[12:45:27.932] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:27.932] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:34:0) after 1m0s
[12:46:27.953] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:34:0)
[12:46:27.953] Timer tick, asking Buildbucket for the build status
[12:46:28.268] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:28.268] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:35:0) after 1m0s
[12:47:28.414] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:35:0)
[12:47:28.414] Timer tick, asking Buildbucket for the build status
[12:47:28.548] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:28.548] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:36:0) after 1m0s
[12:48:28.681] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:36:0)
[12:48:28.681] Timer tick, asking Buildbucket for the build status
[12:48:28.812] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:28.812] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:37:0) after 1m0s
[12:49:28.937] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:37:0)
[12:49:28.937] Timer tick, asking Buildbucket for the build status
[12:49:29.045] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:29.045] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:38:0) after 1m0s
[12:50:29.181] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:38:0)
[12:50:29.181] Timer tick, asking Buildbucket for the build status
[12:50:29.332] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:29.332] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:39:0) after 1m0s
[12:51:29.366] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:39:0)
[12:51:29.366] Timer tick, asking Buildbucket for the build status
[12:51:29.757] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:29.757] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:40:0) after 1m0s
[12:52:29.768] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:40:0)
[12:52:29.768] Timer tick, asking Buildbucket for the build status
[12:52:30.032] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:30.032] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:41:0) after 1m0s
[12:53:30.065] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:41:0)
[12:53:30.065] Timer tick, asking Buildbucket for the build status
[12:53:30.235] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:30.235] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:42:0) after 1m0s
[12:54:30.260] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:42:0)
[12:54:30.260] Timer tick, asking Buildbucket for the build status
[12:54:30.364] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:30.364] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:43:0) after 1m0s
[12:55:30.441] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:43:0)
[12:55:30.442] Timer tick, asking Buildbucket for the build status
[12:55:30.822] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:30.822] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:44:0) after 1m0s
[12:56:30.848] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:44:0)
[12:56:30.848] Timer tick, asking Buildbucket for the build status
[12:56:31.095] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:31.095] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:45:0) after 1m0s
[12:57:31.118] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:45:0)
[12:57:31.118] Timer tick, asking Buildbucket for the build status
[12:57:31.427] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:31.427] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:46:0) after 1m0s
[12:58:31.505] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:46:0)
[12:58:31.505] Timer tick, asking Buildbucket for the build status
[12:58:31.689] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:31.689] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:47:0) after 1m0s
[12:59:31.709] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:47:0)
[12:59:31.709] Timer tick, asking Buildbucket for the build status
[12:59:32.139] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:32.139] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:48:0) after 1m0s
[13:00:32.259] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:48:0)
[13:00:32.259] Timer tick, asking Buildbucket for the build status
[13:00:32.998] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:32.998] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:49:0) after 1m0s
[13:01:33.087] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:49:0)
[13:01:33.087] Timer tick, asking Buildbucket for the build status
[13:01:33.219] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:33.219] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:50:0) after 1m0s
[13:02:33.412] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:50:0)
[13:02:33.412] Timer tick, asking Buildbucket for the build status
[13:02:33.641] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:33.641] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:51:0) after 1m0s
[13:03:33.665] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:51:0)
[13:03:33.666] Timer tick, asking Buildbucket for the build status
[13:03:33.849] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:33.849] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:52:0) after 1m0s
[13:04:33.971] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:52:0)
[13:04:33.971] Timer tick, asking Buildbucket for the build status
[13:04:34.561] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:34.561] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:53:0) after 1m0s
[13:05:34.600] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:53:0)
[13:05:34.600] Timer tick, asking Buildbucket for the build status
[13:05:34.836] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:34.836] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:54:0) after 1m0s
[13:06:34.914] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:54:0)
[13:06:34.914] Timer tick, asking Buildbucket for the build status
[13:06:35.085] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:35.085] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:55:0) after 1m0s
[13:07:35.217] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:55:0)
[13:07:35.217] Timer tick, asking Buildbucket for the build status
[13:07:36.502] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:36.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:56:0) after 1m0s
[13:08:36.530] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:56:0)
[13:08:36.530] Timer tick, asking Buildbucket for the build status
[13:08:36.649] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:36.649] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:57:0) after 1m0s
[13:09:36.753] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:57:0)
[13:09:36.753] Timer tick, asking Buildbucket for the build status
[13:09:36.890] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:36.890] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:58:0) after 1m0s
[13:10:36.964] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:58:0)
[13:10:36.964] Timer tick, asking Buildbucket for the build status
[13:10:37.054] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:37.055] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:59:0) after 1m0s
[13:11:37.094] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:59:0)
[13:11:37.094] Timer tick, asking Buildbucket for the build status
[13:11:37.439] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:37.439] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:60:0) after 1m0s
[13:12:37.464] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:60:0)
[13:12:37.464] Timer tick, asking Buildbucket for the build status
[13:12:37.551] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:37.551] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:61:0) after 1m0s
[13:13:37.579] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:61:0)
[13:13:37.579] Timer tick, asking Buildbucket for the build status
[13:13:37.708] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:37.708] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:62:0) after 1m0s
[13:14:37.858] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:62:0)
[13:14:37.858] Timer tick, asking Buildbucket for the build status
[13:14:38.248] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:38.248] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:63:0) after 1m0s
[13:15:38.328] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:63:0)
[13:15:38.328] Timer tick, asking Buildbucket for the build status
[13:15:38.502] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:38.502] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:64:0) after 1m0s
[13:16:38.535] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:64:0)
[13:16:38.535] Timer tick, asking Buildbucket for the build status
[13:16:38.635] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:38.635] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:65:0) after 1m0s
[13:17:38.662] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:65:0)
[13:17:38.662] Timer tick, asking Buildbucket for the build status
[13:17:38.771] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:38.771] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:66:0) after 1m0s
[13:18:39.039] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:66:0)
[13:18:39.039] Timer tick, asking Buildbucket for the build status
[13:18:39.276] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:39.277] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:67:0) after 1m0s
[13:19:39.402] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:67:0)
[13:19:39.402] Timer tick, asking Buildbucket for the build status
[13:19:39.525] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:39.525] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:68:0) after 1m0s
[13:20:39.651] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:68:0)
[13:20:39.651] Timer tick, asking Buildbucket for the build status
[13:20:39.917] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:39.917] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:69:0) after 1m0s
[13:21:39.947] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:69:0)
[13:21:39.947] Timer tick, asking Buildbucket for the build status
[13:21:40.036] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:40.036] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:70:0) after 1m0s
[13:22:40.111] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:70:0)
[13:22:40.111] Timer tick, asking Buildbucket for the build status
[13:22:40.238] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:40.238] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:71:0) after 1m0s
[13:23:40.262] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:71:0)
[13:23:40.263] Timer tick, asking Buildbucket for the build status
[13:23:40.359] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:40.359] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:72:0) after 1m0s
[13:24:40.381] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:72:0)
[13:24:40.381] Timer tick, asking Buildbucket for the build status
[13:24:40.632] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:40.632] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:73:0) after 1m0s
[13:25:40.660] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:73:0)
[13:25:40.660] Timer tick, asking Buildbucket for the build status
[13:25:40.732] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:40.732] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:74:0) after 1m0s
[13:26:40.790] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:74:0)
[13:26:40.790] Timer tick, asking Buildbucket for the build status
[13:26:40.969] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:40.969] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:75:0) after 1m0s
[13:27:40.991] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:75:0)
[13:27:40.991] Timer tick, asking Buildbucket for the build status
[13:27:41.093] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:41.093] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:76:0) after 1m0s
[13:28:41.151] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:76:0)
[13:28:41.151] Timer tick, asking Buildbucket for the build status
[13:28:41.268] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:41.268] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:77:0) after 1m0s
[13:29:41.290] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:77:0)
[13:29:41.290] Timer tick, asking Buildbucket for the build status
[13:29:41.427] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:41.427] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:78:0) after 1m0s
[13:30:41.452] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:78:0)
[13:30:41.452] Timer tick, asking Buildbucket for the build status
[13:30:41.775] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:41.775] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:79:0) after 1m0s
[13:31:41.803] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:79:0)
[13:31:41.803] Timer tick, asking Buildbucket for the build status
[13:31:41.923] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:41.923] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:80:0) after 1m0s
[13:32:41.944] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:80:0)
[13:32:41.944] Timer tick, asking Buildbucket for the build status
[13:32:42.064] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:42.064] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:81:0) after 1m0s
[13:33:42.097] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:81:0)
[13:33:42.098] Timer tick, asking Buildbucket for the build status
[13:33:42.207] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:42.207] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:82:0) after 1m0s
[13:34:42.253] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:82:0)
[13:34:42.253] Timer tick, asking Buildbucket for the build status
[13:34:42.346] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:42.346] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:83:0) after 1m0s
[13:35:42.383] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:83:0)
[13:35:42.383] Timer tick, asking Buildbucket for the build status
[13:35:42.605] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:42.605] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:84:0) after 1m0s
[13:36:42.626] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:84:0)
[13:36:42.626] Timer tick, asking Buildbucket for the build status
[13:36:42.721] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:42.721] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:85:0) after 1m0s
[13:37:42.943] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:85:0)
[13:37:42.943] Timer tick, asking Buildbucket for the build status
[13:37:43.066] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:43.066] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:86:0) after 1m0s
[13:38:43.150] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:86:0)
[13:38:43.150] Timer tick, asking Buildbucket for the build status
[13:38:43.602] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:43.602] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:87:0) after 1m0s
[13:39:43.626] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:87:0)
[13:39:43.626] Timer tick, asking Buildbucket for the build status
[13:39:44.104] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:44.104] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:88:0) after 1m0s
[13:40:44.136] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:88:0)
[13:40:44.136] Timer tick, asking Buildbucket for the build status
[13:40:44.287] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:44.287] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:89:0) after 1m0s
[13:41:44.428] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:89:0)
[13:41:44.428] Timer tick, asking Buildbucket for the build status
[13:41:44.508] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:44.508] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:90:0) after 1m0s
[13:42:44.544] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:90:0)
[13:42:44.544] Timer tick, asking Buildbucket for the build status
[13:42:44.669] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:44.669] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:91:0) after 1m0s
[13:43:45.467] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:91:0)
[13:43:45.467] Timer tick, asking Buildbucket for the build status
[13:43:45.663] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:45.663] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:92:0) after 1m0s
[13:44:45.734] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:92:0)
[13:44:45.734] Timer tick, asking Buildbucket for the build status
[13:44:45.911] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:45.911] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:93:0) after 1m0s
[13:45:46.116] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:93:0)
[13:45:46.116] Timer tick, asking Buildbucket for the build status
[13:45:46.464] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:46.464] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:94:0) after 1m0s
[13:46:46.489] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:94:0)
[13:46:46.489] Timer tick, asking Buildbucket for the build status
[13:46:46.687] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:46.687] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:95:0) after 1m0s
[13:47:46.950] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:95:0)
[13:47:46.950] Timer tick, asking Buildbucket for the build status
[13:47:47.258] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:47.258] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:96:0) after 1m0s
[13:48:47.343] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:96:0)
[13:48:47.343] Timer tick, asking Buildbucket for the build status
[13:48:47.524] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:47.524] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:97:0) after 1m0s
[13:49:47.598] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:97:0)
[13:49:47.598] Timer tick, asking Buildbucket for the build status
[13:49:48.032] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:48.032] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:98:0) after 1m0s
[13:50:48.205] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:98:0)
[13:50:48.205] Timer tick, asking Buildbucket for the build status
[13:50:48.343] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:48.343] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:99:0) after 1m0s
[13:51:48.448] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:99:0)
[13:51:48.448] Timer tick, asking Buildbucket for the build status
[13:51:48.567] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:48.567] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:100:0) after 1m0s
[13:52:48.591] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:100:0)
[13:52:48.591] Timer tick, asking Buildbucket for the build status
[13:52:48.674] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:48.674] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:101:0) after 1m0s
[13:53:48.752] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:101:0)
[13:53:48.752] Timer tick, asking Buildbucket for the build status
[13:53:48.901] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:48.901] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:102:0) after 1m0s
[13:54:48.928] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:102:0)
[13:54:48.928] Timer tick, asking Buildbucket for the build status
[13:54:49.512] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:49.513] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:103:0) after 1m0s
[13:55:49.543] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:103:0)
[13:55:49.543] Timer tick, asking Buildbucket for the build status
[13:55:49.626] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:49.626] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:104:0) after 1m0s
[13:56:49.731] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:104:0)
[13:56:49.731] Timer tick, asking Buildbucket for the build status
[13:56:50.104] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:50.104] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:105:0) after 1m0s
[13:57:50.972] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:105:0)
[13:57:50.972] Timer tick, asking Buildbucket for the build status
[13:57:51.049] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:51.049] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:106:0) after 1m0s
[13:58:51.492] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:106:0)
[13:58:51.492] Timer tick, asking Buildbucket for the build status
[13:58:51.650] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:51.651] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:107:0) after 1m0s
[13:59:52.168] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:107:0)
[13:59:52.168] Timer tick, asking Buildbucket for the build status
[13:59:52.250] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:52.250] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:108:0) after 1m0s
[14:00:52.584] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:108:0)
[14:00:52.584] Timer tick, asking Buildbucket for the build status
[14:00:52.708] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:52.708] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:109:0) after 1m0s
[14:01:53.190] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:109:0)
[14:01:53.190] Timer tick, asking Buildbucket for the build status
[14:01:53.397] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:53.397] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:110:0) after 1m0s
[14:02:53.606] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:110:0)
[14:02:53.606] Timer tick, asking Buildbucket for the build status
[14:02:53.782] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:53.782] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:111:0) after 1m0s
[14:03:53.948] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:111:0)
[14:03:53.948] Timer tick, asking Buildbucket for the build status
[14:03:54.028] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:54.028] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:112:0) after 1m0s
[14:04:54.488] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:112:0)
[14:04:54.488] Timer tick, asking Buildbucket for the build status
[14:04:54.810] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:54.810] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:113:0) after 1m0s
[14:05:54.885] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:113:0)
[14:05:54.885] Timer tick, asking Buildbucket for the build status
[14:05:55.114] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:55.114] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:114:0) after 1m0s
[14:06:55.371] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:114:0)
[14:06:55.371] Timer tick, asking Buildbucket for the build status
[14:06:55.464] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:55.464] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:115:0) after 1m0s
[14:07:55.545] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:115:0)
[14:07:55.545] Timer tick, asking Buildbucket for the build status
[14:07:55.653] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:55.653] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:116:0) after 1m0s
[14:08:55.651] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:116:0)
[14:08:55.651] Timer tick, asking Buildbucket for the build status
[14:08:55.840] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:55.840] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:117:0) after 1m0s
[14:09:55.982] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:117:0)
[14:09:55.982] Timer tick, asking Buildbucket for the build status
[14:09:56.059] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:56.059] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:118:0) after 1m0s
[14:10:56.303] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:118:0)
[14:10:56.303] Timer tick, asking Buildbucket for the build status
[14:10:56.491] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:56.492] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:119:0) after 1m0s
[14:11:56.737] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:119:0)
[14:11:56.737] Timer tick, asking Buildbucket for the build status
[14:11:56.822] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:56.822] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:120:0) after 1m0s
[14:12:56.931] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:120:0)
[14:12:56.931] Timer tick, asking Buildbucket for the build status
[14:12:57.013] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:57.013] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:121:0) after 1m0s
[14:13:57.223] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:121:0)
[14:13:57.223] Timer tick, asking Buildbucket for the build status
[14:13:57.321] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:57.321] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:122:0) after 1m0s
[14:14:57.551] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:122:0)
[14:14:57.551] Timer tick, asking Buildbucket for the build status
[14:14:57.636] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:57.636] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:123:0) after 1m0s
[14:15:57.858] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:123:0)
[14:15:57.858] Timer tick, asking Buildbucket for the build status
[14:15:58.158] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:58.158] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:124:0) after 1m0s
[14:16:58.352] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:124:0)
[14:16:58.352] Timer tick, asking Buildbucket for the build status
[14:16:58.523] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:58.523] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:125:0) after 1m0s
[14:17:58.770] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:125:0)
[14:17:58.770] Timer tick, asking Buildbucket for the build status
[14:17:58.929] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:58.929] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:126:0) after 1m0s
[14:18:58.954] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:126:0)
[14:18:58.954] Timer tick, asking Buildbucket for the build status
[14:18:59.041] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:59.041] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:127:0) after 1m0s
[14:19:59.264] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:127:0)
[14:19:59.264] Timer tick, asking Buildbucket for the build status
[14:19:59.334] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:59.334] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:128:0) after 1m0s
[14:20:59.377] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:128:0)
[14:20:59.377] Timer tick, asking Buildbucket for the build status
[14:20:59.491] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:59.491] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:129:0) after 1m0s
[14:21:59.528] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:129:0)
[14:21:59.528] Timer tick, asking Buildbucket for the build status
[14:21:59.613] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:59.613] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:130:0) after 1m0s
[14:22:59.720] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:130:0)
[14:22:59.720] Timer tick, asking Buildbucket for the build status
[14:22:59.802] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:59.802] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:131:0) after 1m0s
[14:23:59.925] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:131:0)
[14:23:59.925] Timer tick, asking Buildbucket for the build status
[14:24:00.211] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:00.211] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:132:0) after 1m0s
[14:25:00.428] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:132:0)
[14:25:00.428] Timer tick, asking Buildbucket for the build status
[14:25:00.569] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:00.569] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:133:0) after 1m0s
[14:26:00.600] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:133:0)
[14:26:00.600] Timer tick, asking Buildbucket for the build status
[14:26:00.709] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:00.709] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:134:0) after 1m0s
[14:27:00.745] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:134:0)
[14:27:00.745] Timer tick, asking Buildbucket for the build status
[14:27:00.853] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:00.853] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:135:0) after 1m0s
[14:28:00.892] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:135:0)
[14:28:00.892] Timer tick, asking Buildbucket for the build status
[14:28:01.088] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:01.088] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:136:0) after 1m0s
[14:29:01.147] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:136:0)
[14:29:01.147] Timer tick, asking Buildbucket for the build status
[14:29:01.342] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:01.342] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:137:0) after 1m0s
[14:30:01.367] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:137:0)
[14:30:01.367] Timer tick, asking Buildbucket for the build status
[14:30:01.837] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:01.837] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:138:0) after 1m0s
[14:31:01.863] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:138:0)
[14:31:01.863] Timer tick, asking Buildbucket for the build status
[14:31:01.941] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:01.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:139:0) after 1m0s
[14:32:01.974] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:139:0)
[14:32:01.974] Timer tick, asking Buildbucket for the build status
[14:32:02.093] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:02.093] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:140:0) after 1m0s
[14:33:02.139] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:140:0)
[14:33:02.139] Timer tick, asking Buildbucket for the build status
[14:33:02.317] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:02.317] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:141:0) after 1m0s
[14:34:02.359] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:141:0)
[14:34:02.359] Timer tick, asking Buildbucket for the build status
[14:34:02.531] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:02.531] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:142:0) after 1m0s
[14:35:02.558] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:142:0)
[14:35:02.558] Timer tick, asking Buildbucket for the build status
[14:35:02.717] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:02.717] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:143:0) after 1m0s
[14:36:02.742] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:143:0)
[14:36:02.742] Timer tick, asking Buildbucket for the build status
[14:36:03.335] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:03.335] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:144:0) after 1m0s
[14:37:03.372] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:144:0)
[14:37:03.372] Timer tick, asking Buildbucket for the build status
[14:37:03.955] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:03.956] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:145:0) after 1m0s
[14:38:03.983] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:145:0)
[14:38:03.983] Timer tick, asking Buildbucket for the build status
[14:38:04.069] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:04.069] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:146:0) after 1m0s
[14:39:04.126] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:146:0)
[14:39:04.126] Timer tick, asking Buildbucket for the build status
[14:39:04.448] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:04.448] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:147:0) after 1m0s
[14:40:04.479] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:147:0)
[14:40:04.479] Timer tick, asking Buildbucket for the build status
[14:40:04.640] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:04.640] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:148:0) after 1m0s
[14:41:04.666] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:148:0)
[14:41:04.666] Timer tick, asking Buildbucket for the build status
[14:41:04.839] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:04.839] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:149:0) after 1m0s
[14:42:04.867] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:149:0)
[14:42:04.867] Timer tick, asking Buildbucket for the build status
[14:42:04.983] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:04.983] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:150:0) after 1m0s
[14:43:05.021] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:150:0)
[14:43:05.021] Timer tick, asking Buildbucket for the build status
[14:43:05.789] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:05.789] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:151:0) after 1m0s
[14:44:05.817] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:151:0)
[14:44:05.817] Timer tick, asking Buildbucket for the build status
[14:44:08.273] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:08.273] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:152:0) after 1m0s
[14:45:08.331] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:152:0)
[14:45:08.331] Timer tick, asking Buildbucket for the build status
[14:45:08.543] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:08.543] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:153:0) after 1m0s
[14:46:08.571] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:153:0)
[14:46:08.571] Timer tick, asking Buildbucket for the build status
[14:46:09.056] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:09.056] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:154:0) after 1m0s
[14:47:09.095] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:154:0)
[14:47:09.095] Timer tick, asking Buildbucket for the build status
[14:47:09.472] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:09.472] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:155:0) after 1m0s
[14:48:09.501] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:155:0)
[14:48:09.501] Timer tick, asking Buildbucket for the build status
[14:48:10.152] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:10.152] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:156:0) after 1m0s
[14:49:10.270] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:156:0)
[14:49:10.270] Timer tick, asking Buildbucket for the build status
[14:49:10.407] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:10.407] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:157:0) after 1m0s
[14:50:10.439] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:157:0)
[14:50:10.439] Timer tick, asking Buildbucket for the build status
[14:50:10.795] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:10.795] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:158:0) after 1m0s
[14:51:10.823] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:158:0)
[14:51:10.823] Timer tick, asking Buildbucket for the build status
[14:51:11.164] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:11.164] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:159:0) after 1m0s
[14:52:11.194] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:159:0)
[14:52:11.194] Timer tick, asking Buildbucket for the build status
[14:52:11.951] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:11.951] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:160:0) after 1m0s
[14:53:11.984] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:160:0)
[14:53:11.984] Timer tick, asking Buildbucket for the build status
[14:53:12.578] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:12.578] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:161:0) after 1m0s
[14:54:12.607] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:161:0)
[14:54:12.607] Timer tick, asking Buildbucket for the build status
[14:54:12.941] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:12.941] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:162:0) after 1m0s
[14:55:12.968] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:162:0)
[14:55:12.968] Timer tick, asking Buildbucket for the build status
[14:55:13.361] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:13.361] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:163:0) after 1m0s
[14:56:13.511] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:163:0)
[14:56:13.511] Timer tick, asking Buildbucket for the build status
[14:56:15.462] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:15.462] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:164:0) after 1m0s
[14:57:15.504] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:164:0)
[14:57:15.504] Timer tick, asking Buildbucket for the build status
[14:57:15.724] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:15.724] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:165:0) after 1m0s
[14:58:15.749] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:165:0)
[14:58:15.749] Timer tick, asking Buildbucket for the build status
[14:58:16.349] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:16.349] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:166:0) after 1m0s
[14:59:16.609] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:166:0)
[14:59:16.609] Timer tick, asking Buildbucket for the build status
[14:59:16.698] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:16.698] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:167:0) after 1m0s
[15:00:16.867] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:167:0)
[15:00:16.867] Timer tick, asking Buildbucket for the build status
[15:00:16.949] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:16.949] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:168:0) after 1m0s
[15:01:17.260] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:168:0)
[15:01:17.260] Timer tick, asking Buildbucket for the build status
[15:01:17.441] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:17.441] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:169:0) after 1m0s
[15:02:17.700] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:169:0)
[15:02:17.700] Timer tick, asking Buildbucket for the build status
[15:02:18.048] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:18.048] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:170:0) after 1m0s
[15:03:18.075] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:170:0)
[15:03:18.075] Timer tick, asking Buildbucket for the build status
[15:03:18.442] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:18.442] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:171:0) after 1m0s
[15:04:18.837] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:171:0)
[15:04:18.837] Timer tick, asking Buildbucket for the build status
[15:04:18.956] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:18.956] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:172:0) after 1m0s
[15:05:19.159] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:172:0)
[15:05:19.159] Timer tick, asking Buildbucket for the build status
[15:05:19.308] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:19.308] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:173:0) after 1m0s
[15:06:19.626] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:173:0)
[15:06:19.626] Timer tick, asking Buildbucket for the build status
[15:06:21.345] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:21.345] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:174:0) after 1m0s
[15:07:21.372] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:174:0)
[15:07:21.372] Timer tick, asking Buildbucket for the build status
[15:07:21.603] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:21.603] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:175:0) after 1m0s
[15:08:21.760] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:175:0)
[15:08:21.760] Timer tick, asking Buildbucket for the build status
[15:08:22.037] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:22.037] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:176:0) after 1m0s
[15:09:22.646] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:176:0)
[15:09:22.646] Timer tick, asking Buildbucket for the build status
[15:09:22.895] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:22.895] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:177:0) after 1m0s
[15:10:23.179] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:177:0)
[15:10:23.179] Timer tick, asking Buildbucket for the build status
[15:10:23.905] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:23.905] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:178:0) after 1m0s
[15:11:24.384] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:178:0)
[15:11:24.384] Timer tick, asking Buildbucket for the build status
[15:11:24.621] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:24.621] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:179:0) after 1m0s
[15:12:29.246] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:179:0)
[15:12:29.246] Timer tick, asking Buildbucket for the build status
[15:12:29.648] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:29.648] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:180:0) after 1m0s
[15:13:29.695] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:180:0)
[15:13:29.695] Timer tick, asking Buildbucket for the build status
[15:13:29.828] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:29.828] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:181:0) after 1m0s
[15:14:29.940] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:181:0)
[15:14:29.940] Timer tick, asking Buildbucket for the build status
[15:14:30.130] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:30.130] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:182:0) after 1m0s
[15:15:30.203] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:182:0)
[15:15:30.203] Timer tick, asking Buildbucket for the build status
[15:15:30.325] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:30.325] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:183:0) after 1m0s
[15:16:30.359] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:183:0)
[15:16:30.359] Timer tick, asking Buildbucket for the build status
[15:16:30.514] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:30.514] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:184:0) after 1m0s
[15:17:30.550] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:184:0)
[15:17:30.550] Timer tick, asking Buildbucket for the build status
[15:17:31.062] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:31.062] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:185:0) after 1m0s
[15:18:31.123] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:185:0)
[15:18:31.123] Timer tick, asking Buildbucket for the build status
[15:18:31.308] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:31.308] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:186:0) after 1m0s
[15:19:31.339] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:186:0)
[15:19:31.339] Timer tick, asking Buildbucket for the build status
[15:19:31.454] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:31.454] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:187:0) after 1m0s
[15:20:31.487] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:187:0)
[15:20:31.487] Timer tick, asking Buildbucket for the build status
[15:20:31.682] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:31.682] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:188:0) after 1m0s
[15:21:31.707] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:188:0)
[15:21:31.707] Timer tick, asking Buildbucket for the build status
[15:21:31.991] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:31.991] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:189:0) after 1m0s
[15:22:32.072] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:189:0)
[15:22:32.072] Timer tick, asking Buildbucket for the build status
[15:22:32.222] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:32.222] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:190:0) after 1m0s
[15:23:32.301] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:190:0)
[15:23:32.301] Timer tick, asking Buildbucket for the build status
[15:23:32.631] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:32.631] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:191:0) after 1m0s
[15:24:32.613] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:191:0)
[15:24:32.613] Timer tick, asking Buildbucket for the build status
[15:24:33.233] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:33.233] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:192:0) after 1m0s
[15:25:33.264] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:192:0)
[15:25:33.264] Timer tick, asking Buildbucket for the build status
[15:25:33.888] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:33.888] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:193:0) after 1m0s
[15:26:33.958] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:193:0)
[15:26:33.958] Timer tick, asking Buildbucket for the build status
[15:26:34.159] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:34.159] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:194:0) after 1m0s
[15:27:35.515] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:194:0)
[15:27:35.515] Timer tick, asking Buildbucket for the build status
[15:27:35.615] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:35.615] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:195:0) after 1m0s
[15:28:36.144] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:195:0)
[15:28:36.144] Timer tick, asking Buildbucket for the build status
[15:28:36.280] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:36.280] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:196:0) after 1m0s
[15:29:37.992] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:196:0)
[15:29:37.992] Timer tick, asking Buildbucket for the build status
[15:29:38.331] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:38.331] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:197:0) after 1m0s
[15:30:39.033] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:197:0)
[15:30:39.033] Timer tick, asking Buildbucket for the build status
[15:30:39.183] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:39.184] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:198:0) after 1m0s
[15:31:39.235] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:198:0)
[15:31:39.235] Timer tick, asking Buildbucket for the build status
[15:31:39.534] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:39.534] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:199:0) after 1m0s
[15:32:39.847] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:199:0)
[15:32:39.848] Timer tick, asking Buildbucket for the build status
[15:32:39.965] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:39.965] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:200:0) after 1m0s
[15:33:40.094] Handling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:200:0)
[15:33:40.094] Timer tick, asking Buildbucket for the build status
[15:33:40.247] Build 8908591981374077664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:40.247] Scheduling timer "check-buildbucket-build-status" (r8/linux-internal:9074022043593667008:201:0) after 1m0s
[15:34:31.634] Received PubSub notification, asking Buildbucket for the build status
[15:34:31.700] Build 8908591981374077664: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:34:31.700] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "PROD",
"completed_ts": "1562513670338000",
"created_by": "project:r8",
"created_ts": "1562501654228701",
"id": "8908591981374077664",
"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\": \"d31722aab5b3f51eeed7410449d28ee7786c0ae1\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@d31722aab5b3f51eeed7410449d28ee7786c0ae1\", \"title\": \"d31722aab5b3f51eeed7410449d28ee7786c0ae1\", \"url\": \"https://r8.googlesource.com/r8/+/d31722aab5b3f51eeed7410449d28ee7786c0ae1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"d31722aab5b3f51eeed7410449d28ee7786c0ae1\"}}",
"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\": \"d31722aab5b3f51eeed7410449d28ee7786c0ae1\"}, \"id\": \"https://r8.googlesource.com/r8/+/refs/heads/master@d31722aab5b3f51eeed7410449d28ee7786c0ae1\", \"title\": \"d31722aab5b3f51eeed7410449d28ee7786c0ae1\", \"url\": \"https://r8.googlesource.com/r8/+/d31722aab5b3f51eeed7410449d28ee7786c0ae1\"}]}, \"bot_id\": \"luci-r8-ci-internal-0-pquw\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-internal\", \"buildnumber\": 381, \"internal\": \"True\", \"mastername\": \"internal.client.r8\", \"path_config\": \"generic\", \"recipe\": \"rex\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"d31722aab5b3f51eeed7410449d28ee7786c0ae1\"}, \"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-pquw\"], \"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\": [\"4363-d7153e5\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1562501685236982",
"status": "COMPLETED",
"status_changed_ts": "1562513670914104",
"tags": [
"build_address:luci.r8.ci/linux-internal/381",
"builder:linux-internal",
"buildset:commit/git/d31722aab5b3f51eeed7410449d28ee7786c0ae1",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/d31722aab5b3f51eeed7410449d28ee7786c0ae1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074022043593667008",
"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/8908591981374077664/+/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:45e52cb642d14a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1562513670925148",
"url": "https://ci.chromium.org/b/8908591981374077664",
"utcnow_ts": "1562513671692376"
}
}
[15:34:31.700] Invocation finished in 3h20m18.972415216s with status SUCCEEDED