[11:09:18.283] New invocation is queued and will start shortly
[11:09:19.479] Starting the invocation (attempt 1)
[11:09:19.517] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:09:19.517] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:09:19.517] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9074750902967148432",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"767f24dabdb162b7d7c6b2fbf0ac9d433b0ace13\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9074750902967148432",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/767f24dabdb162b7d7c6b2fbf0ac9d433b0ace13",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/767f24dabdb162b7d7c6b2fbf0ac9d433b0ace13",
"gitiles_ref:refs/heads/master"
]
}
[11:09:20.422] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1561806559678247",
"id": "8909320840837236928",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"767f24dabdb162b7d7c6b2fbf0ac9d433b0ace13\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1561806560246212",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8412",
"builder:ToTiOS",
"buildset:commit/git/767f24dabdb162b7d7c6b2fbf0ac9d433b0ace13",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/767f24dabdb162b7d7c6b2fbf0ac9d433b0ace13",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074750902967148432",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8909320840837236928/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:ios/unified_builder_tester",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1561806560246333",
"url": "https://ci.chromium.org/b/8909320840837236928",
"utcnow_ts": "1561806560410523"
}
}
[11:09:20.422] Task URL: https://ci.chromium.org/b/8909320840837236928
[11:09:20.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:2:0) after 1m0s
[11:09:27.162] Received PubSub notification, asking Buildbucket for the build status
[11:09:27.902] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:20.449] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:2:0)
[11:10:20.449] Timer tick, asking Buildbucket for the build status
[11:10:21.827] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:21.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:4:0) after 1m0s
[11:11:22.064] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:4:0)
[11:11:22.064] Timer tick, asking Buildbucket for the build status
[11:11:23.271] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:23.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:5:0) after 1m0s
[11:12:23.290] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:5:0)
[11:12:23.290] Timer tick, asking Buildbucket for the build status
[11:12:24.105] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:24.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:6:0) after 1m0s
[11:13:24.187] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:6:0)
[11:13:24.187] Timer tick, asking Buildbucket for the build status
[11:13:24.993] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:24.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:7:0) after 1m0s
[11:14:25.112] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:7:0)
[11:14:25.112] Timer tick, asking Buildbucket for the build status
[11:14:25.295] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:25.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:8:0) after 1m0s
[11:15:25.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:8:0)
[11:15:25.336] Timer tick, asking Buildbucket for the build status
[11:15:25.606] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:25.606] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:9:0) after 1m0s
[11:16:25.641] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:9:0)
[11:16:25.641] Timer tick, asking Buildbucket for the build status
[11:16:25.759] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:25.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:10:0) after 1m0s
[11:17:25.781] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:10:0)
[11:17:25.781] Timer tick, asking Buildbucket for the build status
[11:17:25.913] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:25.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:11:0) after 1m0s
[11:18:26.952] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:11:0)
[11:18:26.952] Timer tick, asking Buildbucket for the build status
[11:18:27.222] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:27.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:12:0) after 1m0s
[11:19:27.440] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:12:0)
[11:19:27.440] Timer tick, asking Buildbucket for the build status
[11:19:27.597] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:27.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:13:0) after 1m0s
[11:20:27.774] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:13:0)
[11:20:27.774] Timer tick, asking Buildbucket for the build status
[11:20:28.093] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:28.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:14:0) after 1m0s
[11:21:28.446] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:14:0)
[11:21:28.446] Timer tick, asking Buildbucket for the build status
[11:21:28.590] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:28.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:15:0) after 1m0s
[11:22:29.137] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:15:0)
[11:22:29.137] Timer tick, asking Buildbucket for the build status
[11:22:30.345] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:30.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:16:0) after 1m0s
[11:23:30.502] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:16:0)
[11:23:30.502] Timer tick, asking Buildbucket for the build status
[11:23:30.691] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:30.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:17:0) after 1m0s
[11:24:30.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:17:0)
[11:24:30.669] Timer tick, asking Buildbucket for the build status
[11:24:31.022] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:31.022] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:18:0) after 1m0s
[11:25:31.041] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:18:0)
[11:25:31.041] Timer tick, asking Buildbucket for the build status
[11:25:31.151] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:31.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:19:0) after 1m0s
[11:26:31.195] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:19:0)
[11:26:31.195] Timer tick, asking Buildbucket for the build status
[11:26:32.246] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:32.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:20:0) after 1m0s
[11:27:32.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:20:0)
[11:27:32.443] Timer tick, asking Buildbucket for the build status
[11:27:32.636] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:32.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:21:0) after 1m0s
[11:28:32.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:21:0)
[11:28:32.996] Timer tick, asking Buildbucket for the build status
[11:28:33.167] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:33.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:22:0) after 1m0s
[11:29:33.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:22:0)
[11:29:33.356] Timer tick, asking Buildbucket for the build status
[11:29:33.865] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:33.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:23:0) after 1m0s
[11:30:33.903] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:23:0)
[11:30:33.903] Timer tick, asking Buildbucket for the build status
[11:30:34.413] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:34.413] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:24:0) after 1m0s
[11:31:34.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:24:0)
[11:31:34.586] Timer tick, asking Buildbucket for the build status
[11:31:34.888] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:34.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:25:0) after 1m0s
[11:32:34.967] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:25:0)
[11:32:34.967] Timer tick, asking Buildbucket for the build status
[11:32:35.072] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:35.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:26:0) after 1m0s
[11:33:35.327] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:26:0)
[11:33:35.327] Timer tick, asking Buildbucket for the build status
[11:33:36.135] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:36.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:27:0) after 1m0s
[11:34:36.451] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:27:0)
[11:34:36.451] Timer tick, asking Buildbucket for the build status
[11:34:36.929] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:36.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:28:0) after 1m0s
[11:35:37.216] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:28:0)
[11:35:37.216] Timer tick, asking Buildbucket for the build status
[11:35:37.462] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:37.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:29:0) after 1m0s
[11:36:37.558] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:29:0)
[11:36:37.558] Timer tick, asking Buildbucket for the build status
[11:36:39.537] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:39.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:30:0) after 1m0s
[11:37:39.546] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:30:0)
[11:37:39.546] Timer tick, asking Buildbucket for the build status
[11:37:39.725] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:39.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:31:0) after 1m0s
[11:38:39.748] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:31:0)
[11:38:39.748] Timer tick, asking Buildbucket for the build status
[11:38:40.697] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:40.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:32:0) after 1m0s
[11:39:41.051] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:32:0)
[11:39:41.051] Timer tick, asking Buildbucket for the build status
[11:39:41.346] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:41.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:33:0) after 1m0s
[11:40:41.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:33:0)
[11:40:41.466] Timer tick, asking Buildbucket for the build status
[11:40:41.718] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:41.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:34:0) after 1m0s
[11:41:41.750] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:34:0)
[11:41:41.750] Timer tick, asking Buildbucket for the build status
[11:41:43.163] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:43.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:35:0) after 1m0s
[11:42:43.246] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:35:0)
[11:42:43.246] Timer tick, asking Buildbucket for the build status
[11:42:43.712] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:43.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:36:0) after 1m0s
[11:43:43.737] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:36:0)
[11:43:43.737] Timer tick, asking Buildbucket for the build status
[11:43:43.906] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:43.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:37:0) after 1m0s
[11:44:43.928] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:37:0)
[11:44:43.928] Timer tick, asking Buildbucket for the build status
[11:44:44.108] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:44.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:38:0) after 1m0s
[11:45:44.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:38:0)
[11:45:44.136] Timer tick, asking Buildbucket for the build status
[11:45:44.539] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:44.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:39:0) after 1m0s
[11:46:44.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:39:0)
[11:46:44.563] Timer tick, asking Buildbucket for the build status
[11:46:44.670] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:44.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:40:0) after 1m0s
[11:47:44.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:40:0)
[11:47:44.975] Timer tick, asking Buildbucket for the build status
[11:47:45.402] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:45.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:41:0) after 1m0s
[11:48:45.520] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:41:0)
[11:48:45.520] Timer tick, asking Buildbucket for the build status
[11:48:45.699] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:45.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:42:0) after 1m0s
[11:49:45.882] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:42:0)
[11:49:45.882] Timer tick, asking Buildbucket for the build status
[11:49:46.889] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:46.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:43:0) after 1m0s
[11:50:47.008] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:43:0)
[11:50:47.008] Timer tick, asking Buildbucket for the build status
[11:50:47.384] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:47.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:44:0) after 1m0s
[11:51:47.468] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:44:0)
[11:51:47.468] Timer tick, asking Buildbucket for the build status
[11:51:47.917] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:47.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:45:0) after 1m0s
[11:52:47.937] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:45:0)
[11:52:47.937] Timer tick, asking Buildbucket for the build status
[11:52:48.095] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:48.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:46:0) after 1m0s
[11:53:48.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:46:0)
[11:53:48.177] Timer tick, asking Buildbucket for the build status
[11:53:48.341] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:48.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:47:0) after 1m0s
[11:54:48.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:47:0)
[11:54:48.367] Timer tick, asking Buildbucket for the build status
[11:54:49.532] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:49.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:48:0) after 1m0s
[11:55:49.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:48:0)
[11:55:49.663] Timer tick, asking Buildbucket for the build status
[11:55:50.310] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:50.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:49:0) after 1m0s
[11:56:50.353] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:49:0)
[11:56:50.353] Timer tick, asking Buildbucket for the build status
[11:56:50.648] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:50.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:50:0) after 1m0s
[11:57:50.714] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:50:0)
[11:57:50.714] Timer tick, asking Buildbucket for the build status
[11:57:50.945] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:50.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:51:0) after 1m0s
[11:58:50.965] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:51:0)
[11:58:50.965] Timer tick, asking Buildbucket for the build status
[11:58:51.305] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:51.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:52:0) after 1m0s
[11:59:51.320] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:52:0)
[11:59:51.320] Timer tick, asking Buildbucket for the build status
[11:59:51.707] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:51.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:53:0) after 1m0s
[12:00:51.782] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:53:0)
[12:00:51.782] Timer tick, asking Buildbucket for the build status
[12:00:52.089] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:52.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:54:0) after 1m0s
[12:01:52.077] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:54:0)
[12:01:52.077] Timer tick, asking Buildbucket for the build status
[12:01:52.242] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:52.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:55:0) after 1m0s
[12:02:52.263] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:55:0)
[12:02:52.263] Timer tick, asking Buildbucket for the build status
[12:02:52.436] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:52.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:56:0) after 1m0s
[12:03:52.456] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:56:0)
[12:03:52.456] Timer tick, asking Buildbucket for the build status
[12:03:52.582] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:52.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:57:0) after 1m0s
[12:04:52.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:57:0)
[12:04:52.571] Timer tick, asking Buildbucket for the build status
[12:04:52.700] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:52.700] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:58:0) after 1m0s
[12:05:52.721] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:58:0)
[12:05:52.721] Timer tick, asking Buildbucket for the build status
[12:05:52.861] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:52.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:59:0) after 1m0s
[12:06:53.062] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:59:0)
[12:06:53.062] Timer tick, asking Buildbucket for the build status
[12:06:53.309] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:53.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:60:0) after 1m0s
[12:07:53.335] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:60:0)
[12:07:53.335] Timer tick, asking Buildbucket for the build status
[12:07:53.510] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:53.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:61:0) after 1m0s
[12:08:54.006] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:61:0)
[12:08:54.006] Timer tick, asking Buildbucket for the build status
[12:08:54.206] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:54.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:62:0) after 1m0s
[12:09:54.334] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:62:0)
[12:09:54.334] Timer tick, asking Buildbucket for the build status
[12:09:54.533] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:54.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:63:0) after 1m0s
[12:10:54.628] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:63:0)
[12:10:54.628] Timer tick, asking Buildbucket for the build status
[12:10:55.945] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:55.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:64:0) after 1m0s
[12:11:56.349] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:64:0)
[12:11:56.349] Timer tick, asking Buildbucket for the build status
[12:11:56.781] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:56.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:65:0) after 1m0s
[12:12:57.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:65:0)
[12:12:57.004] Timer tick, asking Buildbucket for the build status
[12:12:57.471] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:57.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:66:0) after 1m0s
[12:13:57.843] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:66:0)
[12:13:57.843] Timer tick, asking Buildbucket for the build status
[12:13:57.950] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:57.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:67:0) after 1m0s
[12:14:58.100] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:67:0)
[12:14:58.100] Timer tick, asking Buildbucket for the build status
[12:14:58.355] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:58.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:68:0) after 1m0s
[12:15:58.379] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:68:0)
[12:15:58.379] Timer tick, asking Buildbucket for the build status
[12:15:58.649] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:58.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:69:0) after 1m0s
[12:16:58.640] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:69:0)
[12:16:58.640] Timer tick, asking Buildbucket for the build status
[12:16:59.122] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:59.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:70:0) after 1m0s
[12:17:59.149] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:70:0)
[12:17:59.149] Timer tick, asking Buildbucket for the build status
[12:17:59.271] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:59.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:71:0) after 1m0s
[12:18:59.315] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:71:0)
[12:18:59.315] Timer tick, asking Buildbucket for the build status
[12:18:59.878] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:59.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:72:0) after 1m0s
[12:19:59.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:72:0)
[12:19:59.916] Timer tick, asking Buildbucket for the build status
[12:20:00.046] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:00.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:73:0) after 1m0s
[12:21:00.262] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:73:0)
[12:21:00.262] Timer tick, asking Buildbucket for the build status
[12:21:00.401] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:00.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:74:0) after 1m0s
[12:22:00.720] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:74:0)
[12:22:00.720] Timer tick, asking Buildbucket for the build status
[12:22:02.251] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:02.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:75:0) after 1m0s
[12:23:02.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:75:0)
[12:23:02.389] Timer tick, asking Buildbucket for the build status
[12:23:02.657] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:02.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:76:0) after 1m0s
[12:24:02.737] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:76:0)
[12:24:02.737] Timer tick, asking Buildbucket for the build status
[12:24:03.134] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:03.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:77:0) after 1m0s
[12:25:03.212] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:77:0)
[12:25:03.212] Timer tick, asking Buildbucket for the build status
[12:25:05.054] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:05.054] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:78:0) after 1m0s
[12:26:05.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:78:0)
[12:26:05.123] Timer tick, asking Buildbucket for the build status
[12:26:05.271] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:05.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:79:0) after 1m0s
[12:27:05.306] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:79:0)
[12:27:05.306] Timer tick, asking Buildbucket for the build status
[12:27:05.784] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:05.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:80:0) after 1m0s
[12:28:05.851] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:80:0)
[12:28:05.851] Timer tick, asking Buildbucket for the build status
[12:28:06.799] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:06.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:81:0) after 1m0s
[12:29:06.833] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:81:0)
[12:29:06.833] Timer tick, asking Buildbucket for the build status
[12:29:08.370] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:08.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:82:0) after 1m0s
[12:30:08.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:82:0)
[12:30:08.401] Timer tick, asking Buildbucket for the build status
[12:30:08.870] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:08.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:83:0) after 1m0s
[12:31:08.891] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:83:0)
[12:31:08.891] Timer tick, asking Buildbucket for the build status
[12:31:09.906] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:09.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:84:0) after 1m0s
[12:32:09.968] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:84:0)
[12:32:09.968] Timer tick, asking Buildbucket for the build status
[12:32:10.275] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:10.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:85:0) after 1m0s
[12:33:10.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:85:0)
[12:33:10.298] Timer tick, asking Buildbucket for the build status
[12:33:10.895] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:10.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:86:0) after 1m0s
[12:34:10.964] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:86:0)
[12:34:10.964] Timer tick, asking Buildbucket for the build status
[12:34:11.246] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:11.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:87:0) after 1m0s
[12:35:11.270] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:87:0)
[12:35:11.270] Timer tick, asking Buildbucket for the build status
[12:35:13.169] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:13.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:88:0) after 1m0s
[12:36:13.238] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:88:0)
[12:36:13.238] Timer tick, asking Buildbucket for the build status
[12:36:14.330] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:14.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:89:0) after 1m0s
[12:37:14.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:89:0)
[12:37:14.414] Timer tick, asking Buildbucket for the build status
[12:37:16.348] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:16.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:90:0) after 1m0s
[12:38:16.533] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:90:0)
[12:38:16.533] Timer tick, asking Buildbucket for the build status
[12:38:16.778] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:16.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:91:0) after 1m0s
[12:39:16.859] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:91:0)
[12:39:16.859] Timer tick, asking Buildbucket for the build status
[12:39:16.971] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:16.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:92:0) after 1m0s
[12:40:17.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:92:0)
[12:40:17.177] Timer tick, asking Buildbucket for the build status
[12:40:17.760] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:17.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:93:0) after 1m0s
[12:41:17.920] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:93:0)
[12:41:17.920] Timer tick, asking Buildbucket for the build status
[12:41:18.143] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:18.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:94:0) after 1m0s
[12:42:18.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:94:0)
[12:42:18.138] Timer tick, asking Buildbucket for the build status
[12:42:18.313] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:18.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:95:0) after 1m0s
[12:43:18.339] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:95:0)
[12:43:18.339] Timer tick, asking Buildbucket for the build status
[12:43:18.855] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:18.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:96:0) after 1m0s
[12:44:19.405] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:96:0)
[12:44:19.405] Timer tick, asking Buildbucket for the build status
[12:44:20.082] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:20.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:97:0) after 1m0s
[12:45:20.406] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:97:0)
[12:45:20.406] Timer tick, asking Buildbucket for the build status
[12:45:20.516] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:20.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:98:0) after 1m0s
[12:46:20.730] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:98:0)
[12:46:20.730] Timer tick, asking Buildbucket for the build status
[12:46:20.875] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:20.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:99:0) after 1m0s
[12:47:21.269] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:99:0)
[12:47:21.269] Timer tick, asking Buildbucket for the build status
[12:47:23.494] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:23.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:100:0) after 1m0s
[12:48:23.644] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:100:0)
[12:48:23.644] Timer tick, asking Buildbucket for the build status
[12:48:24.541] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:24.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:101:0) after 1m0s
[12:49:24.657] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:101:0)
[12:49:24.657] Timer tick, asking Buildbucket for the build status
[12:49:25.570] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:25.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:102:0) after 1m0s
[12:50:25.817] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:102:0)
[12:50:25.817] Timer tick, asking Buildbucket for the build status
[12:50:25.992] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:25.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:103:0) after 1m0s
[12:51:26.162] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:103:0)
[12:51:26.162] Timer tick, asking Buildbucket for the build status
[12:51:26.747] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:26.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:104:0) after 1m0s
[12:52:26.886] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:104:0)
[12:52:26.886] Timer tick, asking Buildbucket for the build status
[12:52:27.702] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:27.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:105:0) after 1m0s
[12:53:27.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:105:0)
[12:53:27.754] Timer tick, asking Buildbucket for the build status
[12:53:27.993] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:27.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:106:0) after 1m0s
[12:54:28.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:106:0)
[12:54:28.125] Timer tick, asking Buildbucket for the build status
[12:54:28.399] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:28.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:107:0) after 1m0s
[12:55:28.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:107:0)
[12:55:28.520] Timer tick, asking Buildbucket for the build status
[12:55:28.690] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:28.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:108:0) after 1m0s
[12:56:28.795] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:108:0)
[12:56:28.795] Timer tick, asking Buildbucket for the build status
[12:56:29.094] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:29.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:109:0) after 1m0s
[12:57:29.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:109:0)
[12:57:29.103] Timer tick, asking Buildbucket for the build status
[12:57:30.294] Build 8909320840837236928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:30.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9074750902967148432:110:0) after 1m0s
[12:58:16.917] Received PubSub notification, asking Buildbucket for the build status
[12:58:17.079] Build 8909320840837236928: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:58:17.079] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1561813096009346",
"created_by": "project:chromium",
"created_ts": "1561806559678247",
"id": "8909320840837236928",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"767f24dabdb162b7d7c6b2fbf0ac9d433b0ace13\"}}",
"project": "chromium",
"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\": \"build284-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 8412, \"got_angle_revision\": \"f116aa9c158b91bc966ef0394d666da4b3e7bcb6\", \"got_dawn_revision\": \"eee3e41c554257a0ece66e70b2b4e1390ffa6ab0\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"767f24dabdb162b7d7c6b2fbf0ac9d433b0ace13\", \"got_revision_cp\": \"refs/heads/master@{#673587}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"45ddaacef4d3cd90c58d766380fc1f418f998cd2\", \"got_v8_revision_cp\": \"refs/heads/7.7.166@{#1}\", \"got_webrtc_revision\": \"2ce1da53283cd87219fcd111dcf2c60eb613c79f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28422}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"ios/unified_builder_tester\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"767f24dabdb162b7d7c6b2fbf0ac9d433b0ace13\", \"swarm_hashes\": {\"0\": \"88f0f9375fb10e3895978dbc337567151729fa1e\", \"1\": \"ad5c53b0e20b58d96b53e0e09796d88ee178ec86\", \"10\": \"00109776010e87c26c7eca704f7c939a57ad0465\", \"11\": \"1d5854e9ebba19e93ab2e938c4cca1fdaf9fbce1\", \"12\": \"40944923dccb3b651fa55865a9e40a31b0542739\", \"13\": \"c74c91fd0ad6fbc6421812be8c80212fc596c5a5\", \"14\": \"735d84afee6a0d364829548692fed82854f280de\", \"15\": \"26c2ae3cfefaa32ec5c5050a5775fdf0b2f9c8d5\", \"16\": \"82157da118709cec0beb6859842b4f2ef0c52ac0\", \"2\": \"1bbd849b6d29b22b39f133aef5da4d20ae1c734e\", \"3\": \"373b5ba354f827e7e29a5d41a15e4dad9d4d11af\", \"4\": \"6b3938c8c64faef43a59533791e265b1ef3d281b\", \"5\": \"81bdf5df64f4e786f1187190a55c6755edf199f0\", \"6\": \"e4750b60c4c869ba5e733eae1255518e0479d7d7\", \"7\": \"0ff70fc8029091833f24dc9e53d4b2f14072889b\", \"8\": \"3d05b4bd88732bd54801bec43980694fdc201836\", \"9\": \"4f98d2dfddb32aefc550de2384f18fa2590f16a9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build284-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4351-b85b41c\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1561806564678476",
"status": "COMPLETED",
"status_changed_ts": "1561813096477407",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/8412",
"builder:ToTiOS",
"buildset:commit/git/767f24dabdb162b7d7c6b2fbf0ac9d433b0ace13",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/767f24dabdb162b7d7c6b2fbf0ac9d433b0ace13",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074750902967148432",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8909320840837236928/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:ios/unified_builder_tester",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:45bbbe67f7a6d810",
"user_agent:luci-scheduler"
],
"updated_ts": "1561813096486791",
"url": "https://ci.chromium.org/b/8909320840837236928",
"utcnow_ts": "1561813097068611"
}
}
[12:58:17.079] Invocation finished in 1h48m58.816083905s with status SUCCEEDED