[21:04:17.474] New invocation is queued and will start shortly
[21:04:18.786] Starting the invocation (attempt 1)
[21:04:18.839] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:04:18.839] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:04:18.839] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026244092634990704",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d450ac2a62299f9245b08d61dea90579d991bffb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9026244092634990704",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/d450ac2a62299f9245b08d61dea90579d991bffb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d450ac2a62299f9245b08d61dea90579d991bffb",
"gitiles_ref:refs/heads/master"
]
}
[21:04:19.551] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608066258939593",
"id": "8860814030425385568",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d450ac2a62299f9245b08d61dea90579d991bffb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608066259432606",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/20709",
"builder:ToTiOSDevice",
"buildset:commit/git/d450ac2a62299f9245b08d61dea90579d991bffb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d450ac2a62299f9245b08d61dea90579d991bffb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026244092634990704",
"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/8860814030425385568/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1608066259432760",
"url": "https://ci.chromium.org/b/8860814030425385568",
"utcnow_ts": "1608066259545018"
}
}
[21:04:19.551] Task URL: https://ci.chromium.org/b/8860814030425385568
[21:04:19.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:2:0) after 1m0s
[21:05:19.598] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:2:0)
[21:05:19.598] Timer tick, asking Buildbucket for the build status
[21:05:19.710] Build 8860814030425385568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:19.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:3:0) after 1m0s
[21:06:19.733] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:3:0)
[21:06:19.733] Timer tick, asking Buildbucket for the build status
[21:06:19.846] Build 8860814030425385568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:19.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:4:0) after 1m0s
[21:07:19.885] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:4:0)
[21:07:19.885] Timer tick, asking Buildbucket for the build status
[21:07:20.213] Build 8860814030425385568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:20.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:5:0) after 1m0s
[21:07:50.179] Received PubSub notification, asking Buildbucket for the build status
[21:07:50.265] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:20.235] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:5:0)
[21:08:20.235] Timer tick, asking Buildbucket for the build status
[21:08:20.409] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:20.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:7:0) after 1m0s
[21:09:20.462] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:7:0)
[21:09:20.462] Timer tick, asking Buildbucket for the build status
[21:09:20.566] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:20.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:8:0) after 1m0s
[21:10:20.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:8:0)
[21:10:20.597] Timer tick, asking Buildbucket for the build status
[21:10:20.779] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:20.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:9:0) after 1m0s
[21:11:20.891] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:9:0)
[21:11:20.891] Timer tick, asking Buildbucket for the build status
[21:11:20.965] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:20.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:10:0) after 1m0s
[21:12:21.025] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:10:0)
[21:12:21.025] Timer tick, asking Buildbucket for the build status
[21:12:21.087] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:21.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:11:0) after 1m0s
[21:13:21.143] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:11:0)
[21:13:21.143] Timer tick, asking Buildbucket for the build status
[21:13:21.281] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:21.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:12:0) after 1m0s
[21:14:21.367] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:12:0)
[21:14:21.367] Timer tick, asking Buildbucket for the build status
[21:14:21.434] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:21.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:13:0) after 1m0s
[21:15:21.505] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:13:0)
[21:15:21.505] Timer tick, asking Buildbucket for the build status
[21:15:21.714] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:21.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:14:0) after 1m0s
[21:16:21.811] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:14:0)
[21:16:21.811] Timer tick, asking Buildbucket for the build status
[21:16:21.880] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:21.880] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:15:0) after 1m0s
[21:17:21.939] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:15:0)
[21:17:21.939] Timer tick, asking Buildbucket for the build status
[21:17:21.996] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:21.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:16:0) after 1m0s
[21:18:22.347] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:16:0)
[21:18:22.347] Timer tick, asking Buildbucket for the build status
[21:18:22.434] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:22.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:17:0) after 1m0s
[21:19:22.873] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:17:0)
[21:19:22.873] Timer tick, asking Buildbucket for the build status
[21:19:22.946] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:22.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:18:0) after 1m0s
[21:20:23.074] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:18:0)
[21:20:23.074] Timer tick, asking Buildbucket for the build status
[21:20:23.235] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:23.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:19:0) after 1m0s
[21:21:23.466] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:19:0)
[21:21:23.466] Timer tick, asking Buildbucket for the build status
[21:21:23.532] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:23.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:20:0) after 1m0s
[21:22:24.464] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:20:0)
[21:22:24.464] Timer tick, asking Buildbucket for the build status
[21:22:24.532] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:24.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:21:0) after 1m0s
[21:23:24.679] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:21:0)
[21:23:24.679] Timer tick, asking Buildbucket for the build status
[21:23:24.742] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:24.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:22:0) after 1m0s
[21:24:24.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:22:0)
[21:24:24.975] Timer tick, asking Buildbucket for the build status
[21:24:25.108] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:25.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:23:0) after 1m0s
[21:25:25.102] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:23:0)
[21:25:25.102] Timer tick, asking Buildbucket for the build status
[21:25:25.176] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:25.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:24:0) after 1m0s
[21:26:25.198] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:24:0)
[21:26:25.198] Timer tick, asking Buildbucket for the build status
[21:26:25.331] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:25.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:25:0) after 1m0s
[21:27:25.360] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:25:0)
[21:27:25.360] Timer tick, asking Buildbucket for the build status
[21:27:25.422] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:25.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:26:0) after 1m0s
[21:28:25.451] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:26:0)
[21:28:25.451] Timer tick, asking Buildbucket for the build status
[21:28:25.532] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:25.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:27:0) after 1m0s
[21:29:25.552] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:27:0)
[21:29:25.552] Timer tick, asking Buildbucket for the build status
[21:29:25.890] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:25.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:28:0) after 1m0s
[21:30:26.066] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:28:0)
[21:30:26.066] Timer tick, asking Buildbucket for the build status
[21:30:26.600] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:26.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:29:0) after 1m0s
[21:31:26.639] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:29:0)
[21:31:26.639] Timer tick, asking Buildbucket for the build status
[21:31:26.698] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:26.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:30:0) after 1m0s
[21:32:26.689] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:30:0)
[21:32:26.689] Timer tick, asking Buildbucket for the build status
[21:32:26.744] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:26.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:31:0) after 1m0s
[21:33:26.747] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:31:0)
[21:33:26.747] Timer tick, asking Buildbucket for the build status
[21:33:26.843] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:26.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:32:0) after 1m0s
[21:34:26.866] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:32:0)
[21:34:26.866] Timer tick, asking Buildbucket for the build status
[21:34:27.145] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:27.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:33:0) after 1m0s
[21:35:27.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:33:0)
[21:35:27.197] Timer tick, asking Buildbucket for the build status
[21:35:27.260] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:27.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:34:0) after 1m0s
[21:36:27.270] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:34:0)
[21:36:27.270] Timer tick, asking Buildbucket for the build status
[21:36:27.374] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:27.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:35:0) after 1m0s
[21:37:27.444] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:35:0)
[21:37:27.444] Timer tick, asking Buildbucket for the build status
[21:37:27.541] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:27.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:36:0) after 1m0s
[21:38:27.565] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:36:0)
[21:38:27.565] Timer tick, asking Buildbucket for the build status
[21:38:27.652] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:27.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:37:0) after 1m0s
[21:39:27.678] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:37:0)
[21:39:27.678] Timer tick, asking Buildbucket for the build status
[21:39:27.783] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:27.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:38:0) after 1m0s
[21:40:27.811] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:38:0)
[21:40:27.811] Timer tick, asking Buildbucket for the build status
[21:40:27.869] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:27.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:39:0) after 1m0s
[21:41:27.900] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:39:0)
[21:41:27.900] Timer tick, asking Buildbucket for the build status
[21:41:27.960] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:27.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:40:0) after 1m0s
[21:42:27.983] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:40:0)
[21:42:27.983] Timer tick, asking Buildbucket for the build status
[21:42:28.119] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:28.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:41:0) after 1m0s
[21:43:28.154] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:41:0)
[21:43:28.154] Timer tick, asking Buildbucket for the build status
[21:43:28.204] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:28.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:42:0) after 1m0s
[21:44:28.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:42:0)
[21:44:28.249] Timer tick, asking Buildbucket for the build status
[21:44:28.369] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:28.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:43:0) after 1m0s
[21:45:28.713] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:43:0)
[21:45:28.713] Timer tick, asking Buildbucket for the build status
[21:45:29.152] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:29.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:44:0) after 1m0s
[21:46:29.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:44:0)
[21:46:29.341] Timer tick, asking Buildbucket for the build status
[21:46:29.407] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:29.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:45:0) after 1m0s
[21:47:29.768] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:45:0)
[21:47:29.768] Timer tick, asking Buildbucket for the build status
[21:47:30.107] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:30.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:46:0) after 1m0s
[21:48:30.210] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:46:0)
[21:48:30.210] Timer tick, asking Buildbucket for the build status
[21:48:30.442] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:30.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:47:0) after 1m0s
[21:49:30.580] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:47:0)
[21:49:30.580] Timer tick, asking Buildbucket for the build status
[21:49:30.663] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:30.663] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:48:0) after 1m0s
[21:50:30.730] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:48:0)
[21:50:30.730] Timer tick, asking Buildbucket for the build status
[21:50:30.797] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:30.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:49:0) after 1m0s
[21:51:30.973] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:49:0)
[21:51:30.973] Timer tick, asking Buildbucket for the build status
[21:51:31.062] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:31.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:50:0) after 1m0s
[21:52:31.080] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:50:0)
[21:52:31.080] Timer tick, asking Buildbucket for the build status
[21:52:31.304] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:31.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:51:0) after 1m0s
[21:53:31.371] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:51:0)
[21:53:31.371] Timer tick, asking Buildbucket for the build status
[21:53:31.601] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:31.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:52:0) after 1m0s
[21:54:31.708] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:52:0)
[21:54:31.708] Timer tick, asking Buildbucket for the build status
[21:54:31.923] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:31.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:53:0) after 1m0s
[21:55:31.946] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:53:0)
[21:55:31.947] Timer tick, asking Buildbucket for the build status
[21:55:32.108] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:32.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:54:0) after 1m0s
[21:56:32.213] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:54:0)
[21:56:32.213] Timer tick, asking Buildbucket for the build status
[21:56:32.402] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:32.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:55:0) after 1m0s
[21:57:32.417] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:55:0)
[21:57:32.417] Timer tick, asking Buildbucket for the build status
[21:57:32.499] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:32.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:56:0) after 1m0s
[21:58:32.499] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:56:0)
[21:58:32.499] Timer tick, asking Buildbucket for the build status
[21:58:32.568] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:32.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:57:0) after 1m0s
[21:59:32.633] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:57:0)
[21:59:32.633] Timer tick, asking Buildbucket for the build status
[21:59:32.769] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:32.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:58:0) after 1m0s
[22:00:32.871] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:58:0)
[22:00:32.871] Timer tick, asking Buildbucket for the build status
[22:00:32.965] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:32.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:59:0) after 1m0s
[22:01:33.009] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:59:0)
[22:01:33.009] Timer tick, asking Buildbucket for the build status
[22:01:33.156] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:33.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:60:0) after 1m0s
[22:02:33.208] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:60:0)
[22:02:33.208] Timer tick, asking Buildbucket for the build status
[22:02:33.311] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:33.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:61:0) after 1m0s
[22:03:33.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:61:0)
[22:03:33.388] Timer tick, asking Buildbucket for the build status
[22:03:33.488] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:33.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:62:0) after 1m0s
[22:04:33.570] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:62:0)
[22:04:33.570] Timer tick, asking Buildbucket for the build status
[22:04:33.693] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:33.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:63:0) after 1m0s
[22:05:33.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:63:0)
[22:05:33.731] Timer tick, asking Buildbucket for the build status
[22:05:33.813] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:33.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:64:0) after 1m0s
[22:06:33.865] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:64:0)
[22:06:33.865] Timer tick, asking Buildbucket for the build status
[22:06:33.934] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:33.934] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:65:0) after 1m0s
[22:07:33.949] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:65:0)
[22:07:33.949] Timer tick, asking Buildbucket for the build status
[22:07:34.015] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:34.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:66:0) after 1m0s
[22:08:34.125] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:66:0)
[22:08:34.125] Timer tick, asking Buildbucket for the build status
[22:08:34.194] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:34.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:67:0) after 1m0s
[22:09:34.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:67:0)
[22:09:34.248] Timer tick, asking Buildbucket for the build status
[22:09:34.640] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:34.640] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:68:0) after 1m0s
[22:10:34.738] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:68:0)
[22:10:34.738] Timer tick, asking Buildbucket for the build status
[22:10:34.980] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:34.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:69:0) after 1m0s
[22:11:34.991] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:69:0)
[22:11:34.991] Timer tick, asking Buildbucket for the build status
[22:11:35.133] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:35.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:70:0) after 1m0s
[22:12:35.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:70:0)
[22:12:35.194] Timer tick, asking Buildbucket for the build status
[22:12:35.416] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:35.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:71:0) after 1m0s
[22:13:35.520] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:71:0)
[22:13:35.520] Timer tick, asking Buildbucket for the build status
[22:13:35.574] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:35.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:72:0) after 1m0s
[22:14:35.576] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:72:0)
[22:14:35.576] Timer tick, asking Buildbucket for the build status
[22:14:35.817] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:35.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:73:0) after 1m0s
[22:15:35.852] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:73:0)
[22:15:35.852] Timer tick, asking Buildbucket for the build status
[22:15:36.001] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:36.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:74:0) after 1m0s
[22:16:36.022] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:74:0)
[22:16:36.022] Timer tick, asking Buildbucket for the build status
[22:16:36.140] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:36.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:75:0) after 1m0s
[22:17:36.168] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:75:0)
[22:17:36.168] Timer tick, asking Buildbucket for the build status
[22:17:36.257] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:36.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:76:0) after 1m0s
[22:18:36.282] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:76:0)
[22:18:36.282] Timer tick, asking Buildbucket for the build status
[22:18:36.740] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:36.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:77:0) after 1m0s
[22:19:36.763] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:77:0)
[22:19:36.763] Timer tick, asking Buildbucket for the build status
[22:19:37.216] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:37.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:78:0) after 1m0s
[22:20:37.241] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:78:0)
[22:20:37.241] Timer tick, asking Buildbucket for the build status
[22:20:37.446] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:37.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:79:0) after 1m0s
[22:21:37.443] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:79:0)
[22:21:37.443] Timer tick, asking Buildbucket for the build status
[22:21:37.514] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:37.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:80:0) after 1m0s
[22:22:37.565] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:80:0)
[22:22:37.565] Timer tick, asking Buildbucket for the build status
[22:22:37.628] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:37.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:81:0) after 1m0s
[22:23:37.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:81:0)
[22:23:37.650] Timer tick, asking Buildbucket for the build status
[22:23:37.763] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:37.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:82:0) after 1m0s
[22:24:37.796] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:82:0)
[22:24:37.796] Timer tick, asking Buildbucket for the build status
[22:24:37.928] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:37.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:83:0) after 1m0s
[22:25:37.937] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:83:0)
[22:25:37.937] Timer tick, asking Buildbucket for the build status
[22:25:38.011] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:38.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:84:0) after 1m0s
[22:26:38.039] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:84:0)
[22:26:38.039] Timer tick, asking Buildbucket for the build status
[22:26:38.095] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:38.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:85:0) after 1m0s
[22:27:38.120] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:85:0)
[22:27:38.120] Timer tick, asking Buildbucket for the build status
[22:27:38.213] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:38.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:86:0) after 1m0s
[22:28:38.213] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:86:0)
[22:28:38.213] Timer tick, asking Buildbucket for the build status
[22:28:38.368] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:38.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:87:0) after 1m0s
[22:29:38.958] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:87:0)
[22:29:38.958] Timer tick, asking Buildbucket for the build status
[22:29:39.075] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:39.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:88:0) after 1m0s
[22:30:39.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:88:0)
[22:30:39.457] Timer tick, asking Buildbucket for the build status
[22:30:39.536] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:39.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:89:0) after 1m0s
[22:31:39.778] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:89:0)
[22:31:39.778] Timer tick, asking Buildbucket for the build status
[22:31:40.064] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:40.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:90:0) after 1m0s
[22:32:40.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:90:0)
[22:32:40.194] Timer tick, asking Buildbucket for the build status
[22:32:40.467] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:40.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:91:0) after 1m0s
[22:33:40.530] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:91:0)
[22:33:40.530] Timer tick, asking Buildbucket for the build status
[22:33:40.620] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:40.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:92:0) after 1m0s
[22:34:40.635] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:92:0)
[22:34:40.635] Timer tick, asking Buildbucket for the build status
[22:34:40.859] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:40.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:93:0) after 1m0s
[22:35:40.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:93:0)
[22:35:40.906] Timer tick, asking Buildbucket for the build status
[22:35:40.977] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:40.977] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:94:0) after 1m0s
[22:36:41.002] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:94:0)
[22:36:41.002] Timer tick, asking Buildbucket for the build status
[22:36:41.797] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:41.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:95:0) after 1m0s
[22:37:41.829] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:95:0)
[22:37:41.829] Timer tick, asking Buildbucket for the build status
[22:37:42.076] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:42.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:96:0) after 1m0s
[22:38:42.195] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:96:0)
[22:38:42.195] Timer tick, asking Buildbucket for the build status
[22:38:42.499] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:42.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:97:0) after 1m0s
[22:39:42.550] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:97:0)
[22:39:42.550] Timer tick, asking Buildbucket for the build status
[22:39:42.673] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:42.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:98:0) after 1m0s
[22:40:42.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:98:0)
[22:40:42.697] Timer tick, asking Buildbucket for the build status
[22:40:42.774] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:42.774] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:99:0) after 1m0s
[22:41:43.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:99:0)
[22:41:43.027] Timer tick, asking Buildbucket for the build status
[22:41:43.095] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:43.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:100:0) after 1m0s
[22:42:43.206] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:100:0)
[22:42:43.206] Timer tick, asking Buildbucket for the build status
[22:42:43.420] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:43.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:101:0) after 1m0s
[22:43:43.459] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:101:0)
[22:43:43.459] Timer tick, asking Buildbucket for the build status
[22:43:43.780] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:43.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:102:0) after 1m0s
[22:44:44.152] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:102:0)
[22:44:44.152] Timer tick, asking Buildbucket for the build status
[22:44:44.254] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:44.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:103:0) after 1m0s
[22:45:44.634] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:103:0)
[22:45:44.634] Timer tick, asking Buildbucket for the build status
[22:45:44.714] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:44.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:104:0) after 1m0s
[22:46:44.881] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:104:0)
[22:46:44.881] Timer tick, asking Buildbucket for the build status
[22:46:45.040] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:45.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:105:0) after 1m0s
[22:47:45.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:105:0)
[22:47:45.342] Timer tick, asking Buildbucket for the build status
[22:47:45.473] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:45.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:106:0) after 1m0s
[22:48:45.730] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:106:0)
[22:48:45.730] Timer tick, asking Buildbucket for the build status
[22:48:46.306] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:46.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:107:0) after 1m0s
[22:49:46.354] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:107:0)
[22:49:46.354] Timer tick, asking Buildbucket for the build status
[22:49:46.491] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:46.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:108:0) after 1m0s
[22:50:46.522] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:108:0)
[22:50:46.522] Timer tick, asking Buildbucket for the build status
[22:50:46.679] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:46.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:109:0) after 1m0s
[22:51:46.804] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:109:0)
[22:51:46.804] Timer tick, asking Buildbucket for the build status
[22:51:46.873] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:46.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:110:0) after 1m0s
[22:52:46.935] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:110:0)
[22:52:46.935] Timer tick, asking Buildbucket for the build status
[22:52:46.998] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:46.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:111:0) after 1m0s
[22:53:47.047] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:111:0)
[22:53:47.047] Timer tick, asking Buildbucket for the build status
[22:53:47.112] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:47.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:112:0) after 1m0s
[22:54:47.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:112:0)
[22:54:47.134] Timer tick, asking Buildbucket for the build status
[22:54:47.235] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:47.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:113:0) after 1m0s
[22:55:47.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:113:0)
[22:55:47.307] Timer tick, asking Buildbucket for the build status
[22:55:47.401] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:47.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:114:0) after 1m0s
[22:56:47.479] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:114:0)
[22:56:47.479] Timer tick, asking Buildbucket for the build status
[22:56:47.572] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:47.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:115:0) after 1m0s
[22:57:47.630] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:115:0)
[22:57:47.630] Timer tick, asking Buildbucket for the build status
[22:57:47.710] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:47.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:116:0) after 1m0s
[22:58:47.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:116:0)
[22:58:47.870] Timer tick, asking Buildbucket for the build status
[22:58:48.014] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:48.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:117:0) after 1m0s
[22:59:48.091] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:117:0)
[22:59:48.091] Timer tick, asking Buildbucket for the build status
[22:59:49.711] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:49.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:118:0) after 1m0s
[23:00:49.918] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:118:0)
[23:00:49.918] Timer tick, asking Buildbucket for the build status
[23:00:50.001] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:50.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:119:0) after 1m0s
[23:01:50.068] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:119:0)
[23:01:50.068] Timer tick, asking Buildbucket for the build status
[23:01:50.224] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:50.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:120:0) after 1m0s
[23:02:50.247] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:120:0)
[23:02:50.247] Timer tick, asking Buildbucket for the build status
[23:02:50.677] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:50.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:121:0) after 1m0s
[23:03:51.183] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:121:0)
[23:03:51.183] Timer tick, asking Buildbucket for the build status
[23:03:51.283] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:51.283] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:122:0) after 1m0s
[23:04:51.390] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:122:0)
[23:04:51.390] Timer tick, asking Buildbucket for the build status
[23:04:51.505] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:51.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:123:0) after 1m0s
[23:05:51.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:123:0)
[23:05:51.731] Timer tick, asking Buildbucket for the build status
[23:05:51.805] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:51.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:124:0) after 1m0s
[23:06:51.981] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:124:0)
[23:06:51.981] Timer tick, asking Buildbucket for the build status
[23:06:52.065] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:52.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:125:0) after 1m0s
[23:07:52.302] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:125:0)
[23:07:52.302] Timer tick, asking Buildbucket for the build status
[23:07:52.378] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:52.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:126:0) after 1m0s
[23:08:52.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:126:0)
[23:08:52.605] Timer tick, asking Buildbucket for the build status
[23:08:52.941] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:52.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:127:0) after 1m0s
[23:09:53.016] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:127:0)
[23:09:53.016] Timer tick, asking Buildbucket for the build status
[23:09:53.227] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:53.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:128:0) after 1m0s
[23:10:53.291] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:128:0)
[23:10:53.291] Timer tick, asking Buildbucket for the build status
[23:10:53.358] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:53.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:129:0) after 1m0s
[23:11:53.431] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:129:0)
[23:11:53.431] Timer tick, asking Buildbucket for the build status
[23:11:53.538] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:53.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:130:0) after 1m0s
[23:12:53.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:130:0)
[23:12:53.602] Timer tick, asking Buildbucket for the build status
[23:12:53.745] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:53.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:131:0) after 1m0s
[23:13:53.750] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:131:0)
[23:13:53.750] Timer tick, asking Buildbucket for the build status
[23:13:53.847] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:53.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:132:0) after 1m0s
[23:14:53.869] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:132:0)
[23:14:53.869] Timer tick, asking Buildbucket for the build status
[23:14:54.005] Build 8860814030425385568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:54.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9026244092634990704:133:0) after 1m0s
[23:15:26.752] Received PubSub notification, asking Buildbucket for the build status
[23:15:26.839] Build 8860814030425385568: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:15:26.839] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608074126309998",
"created_by": "project:chromium",
"created_ts": "1608066258939593",
"failure_reason": "BUILD_FAILURE",
"id": "8860814030425385568",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d450ac2a62299f9245b08d61dea90579d991bffb\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[11630/21951] SOLINK libtest_shared_library.dylib libtest_shared_library.dylib.TOC\\nFAILED: libtest_shared_library.dylib libtest_shared_library.dylib.TOC\\nif [ ! -e \\\"./libtest_shared_library.dylib\\\" -o ! -e \\\"./libtest_shared_library.dylib.TOC\\\" ] || /opt/s/...(too long)\\nld: warning: arm64 function not 4-byte aligned: ltmp0 from /opt/s/w/ir/cache/builder/src/third_party/llvm-build/Release+Asserts/lib/clang/12.0.0/lib/darwin/libclang_rt.ios.a(outline_atomic_cas1_1.S.o)\\nld: warning: arm64 function not 4-byte aligned: ltmp0 from /opt/s/w/ir/cache/builder/src/third_party/llvm-build/Release+Asserts/lib/clang/12.0.0/lib/darwin/libclang_rt.ios.a(outline_atomic_cas1_2.S.o)\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}, \"properties\": {\"$build/goma\": {\"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"d450ac2a62299f9245b08d61dea90579d991bffb\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/opt/s/w/ir/cache\", \"temp_dir\": \"/opt/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build716-m9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.clang\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 20709, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"c47b951ecbcbbba653db801bc7eb5f4fa5d72042\", \"got_dawn_revision\": \"b35ae002390ec0ff85d8754e36a9efd9e63d0a79\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"d450ac2a62299f9245b08d61dea90579d991bffb\", \"got_revision_cp\": \"refs/heads/master@{#837225}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"fa44979d90aac8cca42e2fee711d44f23c9c4d67\", \"got_v8_revision\": \"6b82504a52acfe8ff39dfc8c3e052e853e44244f\", \"got_v8_revision_cp\": \"refs/heads/8.9.154@{#1}\", \"got_webrtc_revision\": \"cf8ec1f6867651204d81b14a8c31a86e6eb97572\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32829}\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d450ac2a62299f9245b08d61dea90579d991bffb\", \"xcode_build_version\": \"12a7209\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"ToTiOS\", \"ToTiOSDevice\"], \"caches\": [\"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_12a7209\"], \"cores\": [\"12\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-i7-8700B\"], \"gce\": [\"0\"], \"gpu\": [\"8086\", \"8086:3e9b\"], \"hidpi\": [\"0\"], \"id\": [\"build716-m9\"], \"mac_model\": [\"Macmini8,1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Mac\", \"Mac-10.15\", \"Mac-10.15.6\", \"Mac-10.15.6-19G2021\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.16\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[11630/21951] SOLINK libtest_shared_library.dylib libtest_shared_library.dylib.TOC\\nFAILED: libtest_shared_library.dylib libtest_shared_library.dylib.TOC\\nif [ ! -e \\\"./libtest_shared_library.dylib\\\" -o ! -e \\\"./libtest_shared_library.dylib.TOC\\\" ] || /opt/s/...(too long)\\nld: warning: arm64 function not 4-byte aligned: ltmp0 from /opt/s/w/ir/cache/builder/src/third_party/llvm-build/Release+Asserts/lib/clang/12.0.0/lib/darwin/libclang_rt.ios.a(outline_atomic_cas1_1.S.o)\\nld: warning: arm64 function not 4-byte aligned: ltmp0 from /opt/s/w/ir/cache/builder/src/third_party/llvm-build/Release+Asserts/lib/clang/12.0.0/lib/darwin/libclang_rt.ios.a(outline_atomic_cas1_2.S.o)\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608066469331510",
"status": "COMPLETED",
"status_changed_ts": "1608066469818142",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/20709",
"builder:ToTiOSDevice",
"buildset:commit/git/d450ac2a62299f9245b08d61dea90579d991bffb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d450ac2a62299f9245b08d61dea90579d991bffb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026244092634990704",
"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/8860814030425385568/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:50810965dbd09a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608074126390524",
"url": "https://ci.chromium.org/b/8860814030425385568",
"utcnow_ts": "1608074126829490"
}
}
[23:15:26.839] Invocation finished in 2h11m9.390352229s with status FAILED