[12:16:54.295] New invocation is queued and will start shortly
[12:16:55.478] Starting the invocation (attempt 1)
[12:16:55.511] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:16:55.511] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:16:55.511] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9073387695444839776",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9073387695444839776",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"gitiles_ref:refs/heads/master"
]
}
[12:17:01.265] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563106619648867",
"id": "8907957629154150576",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563106621013953",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12950",
"builder:ToTiOSDevice",
"buildset:commit/git/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073387695444839776",
"scheduler_job_id:chromium/ToTiOSDevice",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8907957629154150576/+/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": "1563106621014051",
"url": "https://ci.chromium.org/b/8907957629154150576",
"utcnow_ts": "1563106621250883"
}
}
[12:17:01.265] Task URL: https://ci.chromium.org/b/8907957629154150576
[12:17:01.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:2:0) after 1m0s
[12:18:08.850] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:2:0)
[12:18:08.850] Timer tick, asking Buildbucket for the build status
[12:18:11.134] Build 8907957629154150576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:18:11.134] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:3:0) after 1m0s
[12:19:01.961] Received PubSub notification, asking Buildbucket for the build status
[12:19:02.389] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:11.226] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:3:0)
[12:19:11.226] Timer tick, asking Buildbucket for the build status
[12:19:11.572] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:11.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:5:0) after 1m0s
[12:20:11.591] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:5:0)
[12:20:11.591] Timer tick, asking Buildbucket for the build status
[12:20:12.174] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:12.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:6:0) after 1m0s
[12:21:12.236] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:6:0)
[12:21:12.236] Timer tick, asking Buildbucket for the build status
[12:21:13.226] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:13.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:7:0) after 1m0s
[12:22:13.253] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:7:0)
[12:22:13.253] Timer tick, asking Buildbucket for the build status
[12:22:15.066] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:15.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:8:0) after 1m0s
[12:23:15.083] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:8:0)
[12:23:15.083] Timer tick, asking Buildbucket for the build status
[12:23:16.446] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:16.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:9:0) after 1m0s
[12:24:16.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:9:0)
[12:24:16.519] Timer tick, asking Buildbucket for the build status
[12:24:17.384] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:17.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:10:0) after 1m0s
[12:25:17.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:10:0)
[12:25:17.411] Timer tick, asking Buildbucket for the build status
[12:25:18.119] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:18.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:11:0) after 1m0s
[12:26:18.186] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:11:0)
[12:26:18.186] Timer tick, asking Buildbucket for the build status
[12:26:20.168] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:20.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:12:0) after 1m0s
[12:27:20.226] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:12:0)
[12:27:20.226] Timer tick, asking Buildbucket for the build status
[12:27:22.323] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:22.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:13:0) after 1m0s
[12:28:22.363] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:13:0)
[12:28:22.363] Timer tick, asking Buildbucket for the build status
[12:28:26.353] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:26.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:14:0) after 1m0s
[12:29:26.376] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:14:0)
[12:29:26.376] Timer tick, asking Buildbucket for the build status
[12:29:26.764] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:26.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:15:0) after 1m0s
[12:30:26.841] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:15:0)
[12:30:26.844] Timer tick, asking Buildbucket for the build status
[12:30:27.787] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:27.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:16:0) after 1m0s
[12:31:27.818] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:16:0)
[12:31:27.818] Timer tick, asking Buildbucket for the build status
[12:31:27.996] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:27.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:17:0) after 1m0s
[12:32:28.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:17:0)
[12:32:28.027] Timer tick, asking Buildbucket for the build status
[12:32:30.071] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:30.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:18:0) after 1m0s
[12:33:30.098] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:18:0)
[12:33:30.098] Timer tick, asking Buildbucket for the build status
[12:33:30.464] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:30.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:19:0) after 1m0s
[12:34:30.460] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:19:0)
[12:34:30.460] Timer tick, asking Buildbucket for the build status
[12:34:30.748] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:30.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:20:0) after 1m0s
[12:35:30.821] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:20:0)
[12:35:30.821] Timer tick, asking Buildbucket for the build status
[12:35:32.958] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:32.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:21:0) after 1m0s
[12:36:32.970] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:21:0)
[12:36:32.970] Timer tick, asking Buildbucket for the build status
[12:36:33.616] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:33.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:22:0) after 1m0s
[12:37:33.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:22:0)
[12:37:33.653] Timer tick, asking Buildbucket for the build status
[12:37:34.124] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:34.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:23:0) after 1m0s
[12:38:34.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:23:0)
[12:38:34.145] Timer tick, asking Buildbucket for the build status
[12:38:34.683] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:34.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:24:0) after 1m0s
[12:39:34.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:24:0)
[12:39:34.725] Timer tick, asking Buildbucket for the build status
[12:39:34.894] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:34.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:25:0) after 1m0s
[12:40:34.918] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:25:0)
[12:40:34.918] Timer tick, asking Buildbucket for the build status
[12:40:37.792] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:37.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:26:0) after 1m0s
[12:41:37.832] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:26:0)
[12:41:37.832] Timer tick, asking Buildbucket for the build status
[12:41:38.103] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:38.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:27:0) after 1m0s
[12:42:38.139] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:27:0)
[12:42:38.139] Timer tick, asking Buildbucket for the build status
[12:42:38.551] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:38.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:28:0) after 1m0s
[12:43:38.576] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:28:0)
[12:43:38.577] Timer tick, asking Buildbucket for the build status
[12:43:38.710] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:38.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:29:0) after 1m0s
[12:44:38.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:29:0)
[12:44:38.740] Timer tick, asking Buildbucket for the build status
[12:44:39.096] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:39.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:30:0) after 1m0s
[12:45:39.167] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:30:0)
[12:45:39.167] Timer tick, asking Buildbucket for the build status
[12:45:39.285] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:39.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:31:0) after 1m0s
[12:46:39.311] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:31:0)
[12:46:39.311] Timer tick, asking Buildbucket for the build status
[12:46:39.919] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:39.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:32:0) after 1m0s
[12:47:39.939] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:32:0)
[12:47:39.939] Timer tick, asking Buildbucket for the build status
[12:47:40.786] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:40.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:33:0) after 1m0s
[12:48:40.806] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:33:0)
[12:48:40.806] Timer tick, asking Buildbucket for the build status
[12:48:43.518] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:43.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:34:0) after 1m0s
[12:49:43.581] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:34:0)
[12:49:43.581] Timer tick, asking Buildbucket for the build status
[12:49:45.381] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:45.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:35:0) after 1m0s
[12:50:45.539] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:35:0)
[12:50:45.539] Timer tick, asking Buildbucket for the build status
[12:50:48.993] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:48.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:36:0) after 1m0s
[12:51:49.026] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:36:0)
[12:51:49.026] Timer tick, asking Buildbucket for the build status
[12:51:49.305] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:49.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:37:0) after 1m0s
[12:52:49.377] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:37:0)
[12:52:49.377] Timer tick, asking Buildbucket for the build status
[12:52:49.712] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:49.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:38:0) after 1m0s
[12:53:49.741] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:38:0)
[12:53:49.741] Timer tick, asking Buildbucket for the build status
[12:53:52.430] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:52.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:39:0) after 1m0s
[12:54:52.466] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:39:0)
[12:54:52.466] Timer tick, asking Buildbucket for the build status
[12:54:52.652] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:52.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:40:0) after 1m0s
[12:55:52.664] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:40:0)
[12:55:52.664] Timer tick, asking Buildbucket for the build status
[12:55:54.364] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:54.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:41:0) after 1m0s
[12:56:54.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:41:0)
[12:56:54.409] Timer tick, asking Buildbucket for the build status
[12:56:54.623] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:54.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:42:0) after 1m0s
[12:57:54.647] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:42:0)
[12:57:54.647] Timer tick, asking Buildbucket for the build status
[12:57:55.108] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:55.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:43:0) after 1m0s
[12:58:55.143] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:43:0)
[12:58:55.143] Timer tick, asking Buildbucket for the build status
[12:58:57.525] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:57.525] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:44:0) after 1m0s
[12:59:57.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:44:0)
[12:59:57.597] Timer tick, asking Buildbucket for the build status
[12:59:58.055] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:58.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:45:0) after 1m0s
[13:00:58.127] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:45:0)
[13:00:58.127] Timer tick, asking Buildbucket for the build status
[13:01:03.135] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:03.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:46:0) after 1m0s
[13:02:03.214] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:46:0)
[13:02:03.214] Timer tick, asking Buildbucket for the build status
[13:02:03.759] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:03.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:47:0) after 1m0s
[13:03:03.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:47:0)
[13:03:03.809] Timer tick, asking Buildbucket for the build status
[13:03:04.310] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:04.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:48:0) after 1m0s
[13:04:04.434] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:48:0)
[13:04:04.434] Timer tick, asking Buildbucket for the build status
[13:04:04.585] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:04.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:49:0) after 1m0s
[13:05:04.828] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:49:0)
[13:05:04.828] Timer tick, asking Buildbucket for the build status
[13:05:05.291] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:05.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:50:0) after 1m0s
[13:06:05.399] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:50:0)
[13:06:05.399] Timer tick, asking Buildbucket for the build status
[13:06:06.880] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:06.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:51:0) after 1m0s
[13:07:07.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:51:0)
[13:07:07.125] Timer tick, asking Buildbucket for the build status
[13:07:07.898] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:07.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:52:0) after 1m0s
[13:08:08.066] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:52:0)
[13:08:08.066] Timer tick, asking Buildbucket for the build status
[13:08:08.312] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:08.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:53:0) after 1m0s
[13:09:08.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:53:0)
[13:09:08.336] Timer tick, asking Buildbucket for the build status
[13:09:08.501] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:08.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:54:0) after 1m0s
[13:10:08.624] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:54:0)
[13:10:08.624] Timer tick, asking Buildbucket for the build status
[13:10:10.280] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:10.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:55:0) after 1m0s
[13:11:10.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:55:0)
[13:11:10.404] Timer tick, asking Buildbucket for the build status
[13:11:11.229] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:11.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:56:0) after 1m0s
[13:12:11.452] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:56:0)
[13:12:11.452] Timer tick, asking Buildbucket for the build status
[13:12:11.970] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:11.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:57:0) after 1m0s
[13:13:12.132] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:57:0)
[13:13:12.132] Timer tick, asking Buildbucket for the build status
[13:13:12.249] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:12.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:58:0) after 1m0s
[13:14:12.456] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:58:0)
[13:14:12.456] Timer tick, asking Buildbucket for the build status
[13:14:12.624] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:12.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:59:0) after 1m0s
[13:15:12.646] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:59:0)
[13:15:12.646] Timer tick, asking Buildbucket for the build status
[13:15:14.716] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:14.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:60:0) after 1m0s
[13:16:14.831] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:60:0)
[13:16:14.831] Timer tick, asking Buildbucket for the build status
[13:16:14.993] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:14.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:61:0) after 1m0s
[13:17:15.117] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:61:0)
[13:17:15.117] Timer tick, asking Buildbucket for the build status
[13:17:15.690] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:15.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:62:0) after 1m0s
[13:18:15.865] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:62:0)
[13:18:15.865] Timer tick, asking Buildbucket for the build status
[13:18:16.016] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:16.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:63:0) after 1m0s
[13:19:16.393] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:63:0)
[13:19:16.393] Timer tick, asking Buildbucket for the build status
[13:19:16.740] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:16.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:64:0) after 1m0s
[13:20:22.882] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:64:0)
[13:20:22.882] Timer tick, asking Buildbucket for the build status
[13:20:23.130] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:23.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:65:0) after 1m0s
[13:21:23.213] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:65:0)
[13:21:23.213] Timer tick, asking Buildbucket for the build status
[13:21:24.406] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:24.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:66:0) after 1m0s
[13:22:24.503] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:66:0)
[13:22:24.503] Timer tick, asking Buildbucket for the build status
[13:22:24.969] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:24.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:67:0) after 1m0s
[13:23:25.042] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:67:0)
[13:23:25.042] Timer tick, asking Buildbucket for the build status
[13:23:26.168] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:26.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:68:0) after 1m0s
[13:24:26.200] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:68:0)
[13:24:26.200] Timer tick, asking Buildbucket for the build status
[13:24:26.712] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:26.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:69:0) after 1m0s
[13:25:26.748] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:69:0)
[13:25:26.748] Timer tick, asking Buildbucket for the build status
[13:25:26.947] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:26.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:70:0) after 1m0s
[13:26:27.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:70:0)
[13:26:27.004] Timer tick, asking Buildbucket for the build status
[13:26:28.579] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:28.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:71:0) after 1m0s
[13:27:28.648] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:71:0)
[13:27:28.648] Timer tick, asking Buildbucket for the build status
[13:27:33.422] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:33.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:72:0) after 1m0s
[13:28:33.447] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:72:0)
[13:28:33.447] Timer tick, asking Buildbucket for the build status
[13:28:33.916] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:33.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:73:0) after 1m0s
[13:29:34.063] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:73:0)
[13:29:34.063] Timer tick, asking Buildbucket for the build status
[13:29:34.321] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:34.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:74:0) after 1m0s
[13:30:34.384] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:74:0)
[13:30:34.384] Timer tick, asking Buildbucket for the build status
[13:30:34.563] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:34.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:75:0) after 1m0s
[13:31:34.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:75:0)
[13:31:34.624] Timer tick, asking Buildbucket for the build status
[13:31:35.655] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:35.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:76:0) after 1m0s
[13:32:36.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:76:0)
[13:32:36.079] Timer tick, asking Buildbucket for the build status
[13:32:36.494] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:36.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:77:0) after 1m0s
[13:33:36.528] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:77:0)
[13:33:36.528] Timer tick, asking Buildbucket for the build status
[13:33:36.937] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:36.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:78:0) after 1m0s
[13:34:37.069] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:78:0)
[13:34:37.069] Timer tick, asking Buildbucket for the build status
[13:34:38.551] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:38.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:79:0) after 1m0s
[13:35:38.583] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:79:0)
[13:35:38.583] Timer tick, asking Buildbucket for the build status
[13:35:39.534] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:39.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:80:0) after 1m0s
[13:36:39.559] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:80:0)
[13:36:39.559] Timer tick, asking Buildbucket for the build status
[13:36:39.716] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:39.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:81:0) after 1m0s
[13:37:39.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:81:0)
[13:37:39.743] Timer tick, asking Buildbucket for the build status
[13:37:40.187] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:40.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:82:0) after 1m0s
[13:38:40.223] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:82:0)
[13:38:40.223] Timer tick, asking Buildbucket for the build status
[13:38:40.511] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:40.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:83:0) after 1m0s
[13:39:40.537] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:83:0)
[13:39:40.537] Timer tick, asking Buildbucket for the build status
[13:39:40.837] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:40.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:84:0) after 1m0s
[13:40:40.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:84:0)
[13:40:40.871] Timer tick, asking Buildbucket for the build status
[13:40:41.246] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:41.246] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:85:0) after 1m0s
[13:41:41.518] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:85:0)
[13:41:41.518] Timer tick, asking Buildbucket for the build status
[13:41:42.465] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:42.465] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:86:0) after 1m0s
[13:42:42.774] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:86:0)
[13:42:42.774] Timer tick, asking Buildbucket for the build status
[13:42:43.168] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:43.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:87:0) after 1m0s
[13:43:43.502] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:87:0)
[13:43:43.502] Timer tick, asking Buildbucket for the build status
[13:43:43.649] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:43.649] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:88:0) after 1m0s
[13:44:43.816] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:88:0)
[13:44:43.816] Timer tick, asking Buildbucket for the build status
[13:44:44.073] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:44.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:89:0) after 1m0s
[13:45:44.088] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:89:0)
[13:45:44.088] Timer tick, asking Buildbucket for the build status
[13:45:48.556] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:48.556] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:90:0) after 1m0s
[13:46:48.579] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:90:0)
[13:46:48.579] Timer tick, asking Buildbucket for the build status
[13:46:48.949] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:48.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:91:0) after 1m0s
[13:47:49.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:91:0)
[13:47:49.325] Timer tick, asking Buildbucket for the build status
[13:47:49.599] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:49.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:92:0) after 1m0s
[13:48:49.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:92:0)
[13:48:49.950] Timer tick, asking Buildbucket for the build status
[13:48:50.255] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:50.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:93:0) after 1m0s
[13:49:50.268] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:93:0)
[13:49:50.268] Timer tick, asking Buildbucket for the build status
[13:49:52.749] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:52.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:94:0) after 1m0s
[13:50:52.842] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:94:0)
[13:50:52.842] Timer tick, asking Buildbucket for the build status
[13:51:00.239] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:00.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:95:0) after 1m0s
[13:52:00.230] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:95:0)
[13:52:00.230] Timer tick, asking Buildbucket for the build status
[13:52:00.621] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:00.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:96:0) after 1m0s
[13:53:00.739] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:96:0)
[13:53:00.739] Timer tick, asking Buildbucket for the build status
[13:53:04.884] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:04.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:97:0) after 1m0s
[13:54:04.954] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:97:0)
[13:54:04.954] Timer tick, asking Buildbucket for the build status
[13:54:05.204] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:05.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:98:0) after 1m0s
[13:55:05.331] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:98:0)
[13:55:05.331] Timer tick, asking Buildbucket for the build status
[13:55:05.464] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:05.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:99:0) after 1m0s
[13:56:05.725] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:99:0)
[13:56:05.725] Timer tick, asking Buildbucket for the build status
[13:56:10.731] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:10.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:100:0) after 1m0s
[13:57:10.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:100:0)
[13:57:10.776] Timer tick, asking Buildbucket for the build status
[13:57:10.933] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:10.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:101:0) after 1m0s
[13:58:10.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:101:0)
[13:58:10.960] Timer tick, asking Buildbucket for the build status
[13:58:11.537] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:11.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:102:0) after 1m0s
[13:59:11.649] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:102:0)
[13:59:11.649] Timer tick, asking Buildbucket for the build status
[13:59:13.435] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:13.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:103:0) after 1m0s
[14:00:13.517] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:103:0)
[14:00:13.517] Timer tick, asking Buildbucket for the build status
[14:00:13.810] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:13.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:104:0) after 1m0s
[14:01:13.843] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:104:0)
[14:01:13.843] Timer tick, asking Buildbucket for the build status
[14:01:15.117] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:15.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:105:0) after 1m0s
[14:02:15.227] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:105:0)
[14:02:15.227] Timer tick, asking Buildbucket for the build status
[14:02:20.735] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:20.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:106:0) after 1m0s
[14:03:20.864] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:106:0)
[14:03:20.864] Timer tick, asking Buildbucket for the build status
[14:03:21.077] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:21.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:107:0) after 1m0s
[14:04:21.200] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:107:0)
[14:04:21.200] Timer tick, asking Buildbucket for the build status
[14:04:25.174] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:25.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:108:0) after 1m0s
[14:05:25.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:108:0)
[14:05:25.197] Timer tick, asking Buildbucket for the build status
[14:05:25.793] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:25.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:109:0) after 1m0s
[14:06:25.837] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:109:0)
[14:06:25.837] Timer tick, asking Buildbucket for the build status
[14:06:26.752] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:26.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:110:0) after 1m0s
[14:07:26.802] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:110:0)
[14:07:26.802] Timer tick, asking Buildbucket for the build status
[14:07:26.927] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:26.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:111:0) after 1m0s
[14:08:26.992] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:111:0)
[14:08:26.992] Timer tick, asking Buildbucket for the build status
[14:08:27.198] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:27.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:112:0) after 1m0s
[14:09:27.225] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:112:0)
[14:09:27.225] Timer tick, asking Buildbucket for the build status
[14:09:27.524] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:27.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:113:0) after 1m0s
[14:10:27.558] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:113:0)
[14:10:27.558] Timer tick, asking Buildbucket for the build status
[14:10:27.891] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:27.891] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:114:0) after 1m0s
[14:11:27.919] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:114:0)
[14:11:27.919] Timer tick, asking Buildbucket for the build status
[14:11:28.770] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:28.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:115:0) after 1m0s
[14:12:28.795] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:115:0)
[14:12:28.795] Timer tick, asking Buildbucket for the build status
[14:12:29.129] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:29.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:116:0) after 1m0s
[14:13:29.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:116:0)
[14:13:29.194] Timer tick, asking Buildbucket for the build status
[14:13:29.510] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:29.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:117:0) after 1m0s
[14:14:29.640] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:117:0)
[14:14:29.640] Timer tick, asking Buildbucket for the build status
[14:14:29.957] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:29.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:118:0) after 1m0s
[14:15:30.088] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:118:0)
[14:15:30.088] Timer tick, asking Buildbucket for the build status
[14:15:30.445] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:30.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:119:0) after 1m0s
[14:16:30.520] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:119:0)
[14:16:30.520] Timer tick, asking Buildbucket for the build status
[14:16:32.158] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:32.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:120:0) after 1m0s
[14:17:32.187] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:120:0)
[14:17:32.187] Timer tick, asking Buildbucket for the build status
[14:17:32.429] Build 8907957629154150576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:32.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9073387695444839776:121:0) after 1m0s
[14:17:42.334] Received PubSub notification, asking Buildbucket for the build status
[14:17:42.570] Build 8907957629154150576: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[14:17:42.570] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563113861768649",
"created_by": "project:chromium",
"created_ts": "1563106619648867",
"failure_reason": "BUILD_FAILURE",
"id": "8907957629154150576",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed base_unittests (iPhone 6s iOS 12.3.1), boringssl_crypto_tests (iPhone 6s iOS 12.3.1), boringssl_ssl_tests (iPhone 6s iOS 12.3.1), components_unittests (iPhone 6s iOS 12.3.1), crypto_unittests (iPhone 6s iOS 12.3.1), gfx_unittests (iPhone 6s iOS 12.3.1), google_apis_unittests (iPhone 6s iOS 12.3.1), ios_chrome_unittests (iPhone 6s iOS 12.3.1), ios_net_unittests (iPhone 6s iOS 12.3.1), ios_web_inttests (iPhone 6s iOS 12.3.1), ios_web_unittests (iPhone 6s iOS 12.3.1), ios_web_view_inttests (iPhone 6s iOS 12.3.1), net_unittests (iPhone 6s iOS 12.3.1), skia_unittests (iPhone 6s iOS 12.3.1), sql_unittests (iPhone 6s iOS 12.3.1), ui_base_unittests (iPhone 6s iOS 12.3.1), url_unittests (iPhone 6s iOS 12.3.1).\"}, \"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\": \"ToTiOSDevice\", \"buildnumber\": 12950, \"got_angle_revision\": \"c3085ead7055e45b2d24189d5eee86753ea5c2f3\", \"got_dawn_revision\": \"2a1d8c2b1d32f4fe27f4bdc35287e1ebdeb8a86a\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143\", \"got_revision_cp\": \"refs/heads/master@{#677220}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"c2aa402868de1f205107166656c085bfcbacfa00\", \"got_v8_revision_cp\": \"refs/heads/7.7.228@{#1}\", \"got_webrtc_revision\": \"5a29d526be7589f5ba7fb824a749f9088b305070\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28568}\", \"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\": \"c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143\", \"swarm_hashes\": {\"0\": \"a6f11ac426c393d6ed81eb619f8b02a919988baa\", \"1\": \"e5d74c277579d32fa822fa959816a818ed4c321e\", \"10\": \"9fd319c041a103f8726d9c9fbd9f2f36808720a1\", \"11\": \"65b41ba02cac3c66d2bc1a5edfa271c2a9878cbf\", \"12\": \"d36b440da43558cfb7f32722a476c65100fbbf9e\", \"13\": \"fc7254852066d3e31bb1be2ca676c71f2a3a83f4\", \"14\": \"db82a935b368ca2c85f76c231e43421215f65ef5\", \"15\": \"1237dd8516fda27ee1e166f1c1735240a74f33f9\", \"16\": \"41f78ae9491d3a30ad130d39f5f3c29dd0130a2f\", \"2\": \"b80117d8d6b7ccb02758600c2570e7485c1494a2\", \"3\": \"c1539c351516445ac7fd7a183166de2b6fd415c8\", \"4\": \"13e09486636e330b9e21e8d7fde4380536c42239\", \"5\": \"e992a85940517b3f080f820750246f39ea4c4680\", \"6\": \"73a962762de8ed849fe2838a8dd923da2a38ce54\", \"7\": \"793957dd8a1f40ced169aa8cbfad96d8ce38c53d\", \"8\": \"953809351ce438e35388dc762c90b2b51a8ef476\", \"9\": \"8f11341ed579c004540ff8ad1f2f67a5dc4fdafc\"}}, \"ui\": {\"info\": \"Failed base_unittests (iPhone 6s iOS 12.3.1), boringssl_crypto_tests (iPhone 6s iOS 12.3.1), boringssl_ssl_tests (iPhone 6s iOS 12.3.1), components_unittests (iPhone 6s iOS 12.3.1), crypto_unittests (iPhone 6s iOS 12.3.1), gfx_unittests (iPhone 6s iOS 12.3.1), google_apis_unittests (iPhone 6s iOS 12.3.1), ios_chrome_unittests (iPhone 6s iOS 12.3.1), ios_net_unittests (iPhone 6s iOS 12.3.1), ios_web_inttests (iPhone 6s iOS 12.3.1), ios_web_unittests (iPhone 6s iOS 12.3.1), ios_web_view_inttests (iPhone 6s iOS 12.3.1), net_unittests (iPhone 6s iOS 12.3.1), skia_unittests (iPhone 6s iOS 12.3.1), sql_unittests (iPhone 6s iOS 12.3.1), ui_base_unittests (iPhone 6s iOS 12.3.1), url_unittests (iPhone 6s iOS 12.3.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1563106740792576",
"status": "COMPLETED",
"status_changed_ts": "1563106621013953",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12950",
"builder:ToTiOSDevice",
"buildset:commit/git/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c036f7ebc9b60d0f2be8b65aaa15779d7d6bc143",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073387695444839776",
"scheduler_job_id:chromium/ToTiOSDevice",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8907957629154150576/+/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:46093bca075d8310",
"user_agent:luci-scheduler"
],
"updated_ts": "1563113861905483",
"url": "https://ci.chromium.org/b/8907957629154150576",
"utcnow_ts": "1563113862559857"
}
}
[14:17:42.570] Invocation finished in 2h0m48.304229328s with status FAILED