[18:18:46.447] New invocation is queued and will start shortly
[18:18:47.525] Starting the invocation (attempt 1)
[18:18:47.562] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:18:47.562] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:18:47.563] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9076354628479683008",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"683f55dc98aada8fb5830654b63a7daca1246a9b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9076354628479683008",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/683f55dc98aada8fb5830654b63a7daca1246a9b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/683f55dc98aada8fb5830654b63a7daca1246a9b",
"gitiles_ref:refs/heads/master"
]
}
[18:18:48.926] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1560277127713670",
"id": "8910924566489550464",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"683f55dc98aada8fb5830654b63a7daca1246a9b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1560277128707383",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12548",
"builder:ToTiOSDevice",
"buildset:commit/git/683f55dc98aada8fb5830654b63a7daca1246a9b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/683f55dc98aada8fb5830654b63a7daca1246a9b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076354628479683008",
"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/8910924566489550464/+/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": "1560277128707464",
"url": "https://ci.chromium.org/b/8910924566489550464",
"utcnow_ts": "1560277128912142"
}
}
[18:18:48.926] Task URL: https://ci.chromium.org/b/8910924566489550464
[18:18:48.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:2:0) after 1m0s
[18:19:48.951] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:2:0)
[18:19:48.951] Timer tick, asking Buildbucket for the build status
[18:19:49.394] Build 8910924566489550464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:19:49.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:3:0) after 1m0s
[18:20:49.445] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:3:0)
[18:20:49.445] Timer tick, asking Buildbucket for the build status
[18:20:50.341] Build 8910924566489550464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:50.341] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:4:0) after 1m0s
[18:21:02.775] Received PubSub notification, asking Buildbucket for the build status
[18:21:03.861] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:50.363] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:4:0)
[18:21:50.363] Timer tick, asking Buildbucket for the build status
[18:21:51.785] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:51.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:6:0) after 1m0s
[18:22:51.805] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:6:0)
[18:22:51.805] Timer tick, asking Buildbucket for the build status
[18:22:52.200] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:52.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:7:0) after 1m0s
[18:23:57.664] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:7:0)
[18:23:57.664] Timer tick, asking Buildbucket for the build status
[18:23:57.784] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:57.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:8:0) after 1m0s
[18:24:58.026] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:8:0)
[18:24:58.026] Timer tick, asking Buildbucket for the build status
[18:24:58.745] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:58.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:9:0) after 1m0s
[18:25:59.017] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:9:0)
[18:25:59.017] Timer tick, asking Buildbucket for the build status
[18:25:59.125] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:59.125] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:10:0) after 1m0s
[18:26:59.106] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:10:0)
[18:26:59.106] Timer tick, asking Buildbucket for the build status
[18:26:59.241] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:59.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:11:0) after 1m0s
[18:27:59.553] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:11:0)
[18:27:59.553] Timer tick, asking Buildbucket for the build status
[18:27:59.832] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:59.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:12:0) after 1m0s
[18:31:57.285] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:12:0)
[18:31:57.285] Timer tick, asking Buildbucket for the build status
[18:31:57.617] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:57.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:13:0) after 1m0s
[18:32:57.612] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:13:0)
[18:32:57.612] Timer tick, asking Buildbucket for the build status
[18:32:57.776] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:57.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:14:0) after 1m0s
[18:33:57.823] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:14:0)
[18:33:57.823] Timer tick, asking Buildbucket for the build status
[18:33:57.986] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:57.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:15:0) after 1m0s
[18:34:58.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:15:0)
[18:34:58.015] Timer tick, asking Buildbucket for the build status
[18:34:59.279] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:59.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:16:0) after 1m0s
[18:35:59.418] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:16:0)
[18:35:59.418] Timer tick, asking Buildbucket for the build status
[18:36:00.972] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:00.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:17:0) after 1m0s
[18:37:01.040] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:17:0)
[18:37:01.040] Timer tick, asking Buildbucket for the build status
[18:37:01.395] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:01.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:18:0) after 1m0s
[18:38:01.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:18:0)
[18:38:01.414] Timer tick, asking Buildbucket for the build status
[18:38:01.808] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:01.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:19:0) after 1m0s
[18:39:01.851] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:19:0)
[18:39:01.851] Timer tick, asking Buildbucket for the build status
[18:39:01.953] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:01.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:20:0) after 1m0s
[18:40:02.017] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:20:0)
[18:40:02.017] Timer tick, asking Buildbucket for the build status
[18:40:02.587] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:02.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:21:0) after 1m0s
[18:41:02.648] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:21:0)
[18:41:02.648] Timer tick, asking Buildbucket for the build status
[18:41:02.962] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:02.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:22:0) after 1m0s
[18:42:03.034] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:22:0)
[18:42:03.034] Timer tick, asking Buildbucket for the build status
[18:42:05.867] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:05.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:23:0) after 1m0s
[18:43:05.997] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:23:0)
[18:43:05.997] Timer tick, asking Buildbucket for the build status
[18:43:06.417] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:06.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:24:0) after 1m0s
[18:44:06.460] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:24:0)
[18:44:06.460] Timer tick, asking Buildbucket for the build status
[18:44:07.616] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:07.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:25:0) after 1m0s
[18:45:07.638] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:25:0)
[18:45:07.638] Timer tick, asking Buildbucket for the build status
[18:45:07.751] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:07.751] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:26:0) after 1m0s
[18:46:07.802] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:26:0)
[18:46:07.802] Timer tick, asking Buildbucket for the build status
[18:46:08.227] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:08.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:27:0) after 1m0s
[18:47:08.287] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:27:0)
[18:47:08.287] Timer tick, asking Buildbucket for the build status
[18:47:08.564] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:08.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:28:0) after 1m0s
[18:48:08.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:28:0)
[18:48:08.578] Timer tick, asking Buildbucket for the build status
[18:48:08.688] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:08.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:29:0) after 1m0s
[18:49:08.768] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:29:0)
[18:49:08.768] Timer tick, asking Buildbucket for the build status
[18:49:09.605] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:09.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:30:0) after 1m0s
[18:50:09.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:30:0)
[18:50:09.675] Timer tick, asking Buildbucket for the build status
[18:50:09.878] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:09.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:31:0) after 1m0s
[18:51:09.863] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:31:0)
[18:51:09.863] Timer tick, asking Buildbucket for the build status
[18:51:10.386] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:10.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:32:0) after 1m0s
[18:52:10.478] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:32:0)
[18:52:10.478] Timer tick, asking Buildbucket for the build status
[18:52:10.941] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:10.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:33:0) after 1m0s
[18:53:10.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:33:0)
[18:53:10.975] Timer tick, asking Buildbucket for the build status
[18:53:11.102] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:11.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:34:0) after 1m0s
[18:54:11.118] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:34:0)
[18:54:11.118] Timer tick, asking Buildbucket for the build status
[18:54:11.271] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:11.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:35:0) after 1m0s
[18:55:55.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:35:0)
[18:55:55.870] Timer tick, asking Buildbucket for the build status
[18:55:59.104] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:59.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:36:0) after 1m0s
[18:56:59.282] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:36:0)
[18:56:59.282] Timer tick, asking Buildbucket for the build status
[18:56:59.638] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:59.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:37:0) after 1m0s
[18:58:00.913] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:37:0)
[18:58:00.913] Timer tick, asking Buildbucket for the build status
[18:58:01.049] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:01.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:38:0) after 1m0s
[18:59:01.622] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:38:0)
[18:59:01.622] Timer tick, asking Buildbucket for the build status
[18:59:02.314] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:02.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:39:0) after 1m0s
[19:00:02.468] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:39:0)
[19:00:02.468] Timer tick, asking Buildbucket for the build status
[19:00:02.598] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:02.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:40:0) after 1m0s
[19:01:02.661] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:40:0)
[19:01:02.661] Timer tick, asking Buildbucket for the build status
[19:01:04.190] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:04.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:41:0) after 1m0s
[19:02:04.311] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:41:0)
[19:02:04.311] Timer tick, asking Buildbucket for the build status
[19:02:05.151] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:05.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:42:0) after 1m0s
[19:03:05.187] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:42:0)
[19:03:05.187] Timer tick, asking Buildbucket for the build status
[19:03:06.219] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:06.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:43:0) after 1m0s
[19:04:06.399] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:43:0)
[19:04:06.399] Timer tick, asking Buildbucket for the build status
[19:04:07.015] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:07.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:44:0) after 1m0s
[19:05:07.114] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:44:0)
[19:05:07.114] Timer tick, asking Buildbucket for the build status
[19:05:07.493] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:07.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:45:0) after 1m0s
[19:06:07.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:45:0)
[19:06:07.562] Timer tick, asking Buildbucket for the build status
[19:06:09.547] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:09.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:46:0) after 1m0s
[19:07:09.610] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:46:0)
[19:07:09.610] Timer tick, asking Buildbucket for the build status
[19:07:12.326] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:12.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:47:0) after 1m0s
[19:08:12.350] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:47:0)
[19:08:12.350] Timer tick, asking Buildbucket for the build status
[19:08:12.480] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:12.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:48:0) after 1m0s
[19:09:12.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:48:0)
[19:09:12.555] Timer tick, asking Buildbucket for the build status
[19:09:14.297] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:14.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:49:0) after 1m0s
[19:10:14.292] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:49:0)
[19:10:14.292] Timer tick, asking Buildbucket for the build status
[19:10:14.843] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:14.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:50:0) after 1m0s
[19:11:14.899] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:50:0)
[19:11:14.899] Timer tick, asking Buildbucket for the build status
[19:11:15.190] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:15.190] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:51:0) after 1m0s
[19:12:15.217] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:51:0)
[19:12:15.217] Timer tick, asking Buildbucket for the build status
[19:12:17.965] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:17.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:52:0) after 1m0s
[19:13:17.993] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:52:0)
[19:13:17.993] Timer tick, asking Buildbucket for the build status
[19:13:18.223] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:18.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:53:0) after 1m0s
[19:14:18.254] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:53:0)
[19:14:18.254] Timer tick, asking Buildbucket for the build status
[19:14:18.402] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:18.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:54:0) after 1m0s
[19:15:18.414] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:54:0)
[19:15:18.414] Timer tick, asking Buildbucket for the build status
[19:15:18.758] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:18.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:55:0) after 1m0s
[19:16:18.783] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:55:0)
[19:16:18.783] Timer tick, asking Buildbucket for the build status
[19:16:19.207] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:19.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:56:0) after 1m0s
[19:17:19.228] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:56:0)
[19:17:19.228] Timer tick, asking Buildbucket for the build status
[19:17:19.529] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:19.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:57:0) after 1m0s
[19:18:19.744] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:57:0)
[19:18:19.744] Timer tick, asking Buildbucket for the build status
[19:18:19.894] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:19.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:58:0) after 1m0s
[19:19:19.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:58:0)
[19:19:19.906] Timer tick, asking Buildbucket for the build status
[19:19:20.027] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:20.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:59:0) after 1m0s
[19:20:20.130] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:59:0)
[19:20:20.130] Timer tick, asking Buildbucket for the build status
[19:20:21.871] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:21.871] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:60:0) after 1m0s
[19:21:21.895] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:60:0)
[19:21:21.895] Timer tick, asking Buildbucket for the build status
[19:21:22.056] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:22.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:61:0) after 1m0s
[19:22:22.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:61:0)
[19:22:22.135] Timer tick, asking Buildbucket for the build status
[19:22:22.827] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:22.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:62:0) after 1m0s
[19:23:22.987] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:62:0)
[19:23:22.987] Timer tick, asking Buildbucket for the build status
[19:23:23.099] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:23.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:63:0) after 1m0s
[19:24:23.134] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:63:0)
[19:24:23.134] Timer tick, asking Buildbucket for the build status
[19:24:24.601] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:24.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:64:0) after 1m0s
[19:25:24.631] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:64:0)
[19:25:24.631] Timer tick, asking Buildbucket for the build status
[19:25:24.740] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:24.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:65:0) after 1m0s
[19:26:24.917] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:65:0)
[19:26:24.917] Timer tick, asking Buildbucket for the build status
[19:26:27.146] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:27.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:66:0) after 1m0s
[19:27:27.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:66:0)
[19:27:27.197] Timer tick, asking Buildbucket for the build status
[19:27:27.534] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:27.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:67:0) after 1m0s
[19:28:27.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:67:0)
[19:28:27.527] Timer tick, asking Buildbucket for the build status
[19:28:27.890] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:27.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:68:0) after 1m0s
[19:29:27.916] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:68:0)
[19:29:27.916] Timer tick, asking Buildbucket for the build status
[19:29:30.111] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:30.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:69:0) after 1m0s
[19:30:30.332] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:69:0)
[19:30:30.332] Timer tick, asking Buildbucket for the build status
[19:30:30.866] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:30.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:70:0) after 1m0s
[19:31:30.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:70:0)
[19:31:30.906] Timer tick, asking Buildbucket for the build status
[19:31:31.459] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:31.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:71:0) after 1m0s
[19:32:31.524] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:71:0)
[19:32:31.524] Timer tick, asking Buildbucket for the build status
[19:32:33.132] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:33.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:72:0) after 1m0s
[19:33:33.156] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:72:0)
[19:33:33.156] Timer tick, asking Buildbucket for the build status
[19:33:33.337] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:33.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:73:0) after 1m0s
[19:34:33.432] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:73:0)
[19:34:33.432] Timer tick, asking Buildbucket for the build status
[19:34:33.564] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:33.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:74:0) after 1m0s
[19:35:33.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:74:0)
[19:35:33.669] Timer tick, asking Buildbucket for the build status
[19:35:33.794] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:33.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:75:0) after 1m0s
[19:36:33.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:75:0)
[19:36:33.870] Timer tick, asking Buildbucket for the build status
[19:36:33.998] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:33.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:76:0) after 1m0s
[19:37:34.070] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:76:0)
[19:37:34.070] Timer tick, asking Buildbucket for the build status
[19:37:34.410] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:34.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:77:0) after 1m0s
[19:38:34.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:77:0)
[19:38:34.574] Timer tick, asking Buildbucket for the build status
[19:38:36.137] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:36.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:78:0) after 1m0s
[19:39:36.161] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:78:0)
[19:39:36.161] Timer tick, asking Buildbucket for the build status
[19:39:36.949] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:36.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:79:0) after 1m0s
[19:40:36.969] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:79:0)
[19:40:36.969] Timer tick, asking Buildbucket for the build status
[19:40:38.063] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:38.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:80:0) after 1m0s
[19:41:38.161] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:80:0)
[19:41:38.161] Timer tick, asking Buildbucket for the build status
[19:41:38.272] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:38.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:81:0) after 1m0s
[19:42:38.301] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:81:0)
[19:42:38.301] Timer tick, asking Buildbucket for the build status
[19:42:38.509] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:38.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:82:0) after 1m0s
[19:43:38.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:82:0)
[19:43:38.562] Timer tick, asking Buildbucket for the build status
[19:43:38.841] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:38.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:83:0) after 1m0s
[19:44:38.963] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:83:0)
[19:44:38.963] Timer tick, asking Buildbucket for the build status
[19:44:39.350] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:39.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:84:0) after 1m0s
[19:45:39.449] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:84:0)
[19:45:39.449] Timer tick, asking Buildbucket for the build status
[19:45:42.811] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:42.811] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:85:0) after 1m0s
[19:46:42.965] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:85:0)
[19:46:42.965] Timer tick, asking Buildbucket for the build status
[19:46:43.286] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:43.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:86:0) after 1m0s
[19:47:43.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:86:0)
[19:47:43.375] Timer tick, asking Buildbucket for the build status
[19:47:44.718] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:44.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:87:0) after 1m0s
[19:48:44.811] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:87:0)
[19:48:44.811] Timer tick, asking Buildbucket for the build status
[19:48:45.093] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:45.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:88:0) after 1m0s
[19:49:45.191] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:88:0)
[19:49:45.191] Timer tick, asking Buildbucket for the build status
[19:49:45.549] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:45.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:89:0) after 1m0s
[19:50:45.538] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:89:0)
[19:50:45.539] Timer tick, asking Buildbucket for the build status
[19:50:46.989] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:46.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:90:0) after 1m0s
[19:51:46.971] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:90:0)
[19:51:46.971] Timer tick, asking Buildbucket for the build status
[19:51:47.273] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:47.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:91:0) after 1m0s
[19:52:47.351] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:91:0)
[19:52:47.351] Timer tick, asking Buildbucket for the build status
[19:52:47.642] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:47.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:92:0) after 1m0s
[19:53:47.670] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:92:0)
[19:53:47.670] Timer tick, asking Buildbucket for the build status
[19:53:47.800] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:47.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:93:0) after 1m0s
[19:54:47.935] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:93:0)
[19:54:47.935] Timer tick, asking Buildbucket for the build status
[19:54:48.316] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:48.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:94:0) after 1m0s
[19:55:48.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:94:0)
[19:55:48.343] Timer tick, asking Buildbucket for the build status
[19:55:48.471] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:48.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:95:0) after 1m0s
[19:56:48.510] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:95:0)
[19:56:48.510] Timer tick, asking Buildbucket for the build status
[19:56:48.597] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:48.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:96:0) after 1m0s
[19:57:48.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:96:0)
[19:57:48.623] Timer tick, asking Buildbucket for the build status
[19:57:50.693] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:50.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:97:0) after 1m0s
[19:58:50.718] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:97:0)
[19:58:50.718] Timer tick, asking Buildbucket for the build status
[19:58:52.563] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:52.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:98:0) after 1m0s
[19:59:52.588] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:98:0)
[19:59:52.588] Timer tick, asking Buildbucket for the build status
[19:59:52.679] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:52.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:99:0) after 1m0s
[20:00:52.880] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:99:0)
[20:00:52.880] Timer tick, asking Buildbucket for the build status
[20:00:53.044] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:53.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:100:0) after 1m0s
[20:01:53.068] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:100:0)
[20:01:53.068] Timer tick, asking Buildbucket for the build status
[20:01:54.117] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:54.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:101:0) after 1m0s
[20:02:54.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:101:0)
[20:02:54.250] Timer tick, asking Buildbucket for the build status
[20:02:54.351] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:54.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:102:0) after 1m0s
[20:03:54.471] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:102:0)
[20:03:54.471] Timer tick, asking Buildbucket for the build status
[20:03:56.281] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:56.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:103:0) after 1m0s
[20:04:56.358] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:103:0)
[20:04:56.358] Timer tick, asking Buildbucket for the build status
[20:04:57.779] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:57.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:104:0) after 1m0s
[20:05:57.838] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:104:0)
[20:05:57.838] Timer tick, asking Buildbucket for the build status
[20:05:58.374] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:58.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:105:0) after 1m0s
[20:06:58.463] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:105:0)
[20:06:58.463] Timer tick, asking Buildbucket for the build status
[20:06:59.075] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:59.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:106:0) after 1m0s
[20:07:59.109] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:106:0)
[20:07:59.109] Timer tick, asking Buildbucket for the build status
[20:07:59.261] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:59.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:107:0) after 1m0s
[20:08:59.378] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:107:0)
[20:08:59.378] Timer tick, asking Buildbucket for the build status
[20:09:00.303] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:00.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:108:0) after 1m0s
[20:10:00.321] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:108:0)
[20:10:00.321] Timer tick, asking Buildbucket for the build status
[20:10:01.994] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:01.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:109:0) after 1m0s
[20:11:02.089] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:109:0)
[20:11:02.089] Timer tick, asking Buildbucket for the build status
[20:11:02.419] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:02.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:110:0) after 1m0s
[20:12:02.446] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:110:0)
[20:12:02.446] Timer tick, asking Buildbucket for the build status
[20:12:03.089] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:03.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:111:0) after 1m0s
[20:13:03.167] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:111:0)
[20:13:03.168] Timer tick, asking Buildbucket for the build status
[20:13:03.999] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:03.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:112:0) after 1m0s
[20:14:04.024] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:112:0)
[20:14:04.024] Timer tick, asking Buildbucket for the build status
[20:14:05.537] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:05.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:113:0) after 1m0s
[20:15:05.622] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:113:0)
[20:15:05.622] Timer tick, asking Buildbucket for the build status
[20:15:05.791] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:05.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:114:0) after 1m0s
[20:16:05.813] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:114:0)
[20:16:05.813] Timer tick, asking Buildbucket for the build status
[20:16:06.408] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:06.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:115:0) after 1m0s
[20:17:06.431] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:115:0)
[20:17:06.431] Timer tick, asking Buildbucket for the build status
[20:17:06.553] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:06.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:116:0) after 1m0s
[20:18:06.610] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:116:0)
[20:18:06.610] Timer tick, asking Buildbucket for the build status
[20:18:09.069] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:09.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:117:0) after 1m0s
[20:19:09.103] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:117:0)
[20:19:09.103] Timer tick, asking Buildbucket for the build status
[20:19:09.519] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:09.519] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:118:0) after 1m0s
[20:20:09.586] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:118:0)
[20:20:09.586] Timer tick, asking Buildbucket for the build status
[20:20:10.344] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:10.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:119:0) after 1m0s
[20:21:10.402] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:119:0)
[20:21:10.402] Timer tick, asking Buildbucket for the build status
[20:21:10.582] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:10.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:120:0) after 1m0s
[20:22:10.625] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:120:0)
[20:22:10.625] Timer tick, asking Buildbucket for the build status
[20:22:10.750] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:10.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:121:0) after 1m0s
[20:23:10.919] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:121:0)
[20:23:10.919] Timer tick, asking Buildbucket for the build status
[20:23:11.295] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:11.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:122:0) after 1m0s
[20:24:11.358] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:122:0)
[20:24:11.358] Timer tick, asking Buildbucket for the build status
[20:24:11.498] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:11.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:123:0) after 1m0s
[20:25:11.583] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:123:0)
[20:25:11.583] Timer tick, asking Buildbucket for the build status
[20:25:11.914] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:11.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:124:0) after 1m0s
[20:26:11.947] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:124:0)
[20:26:11.947] Timer tick, asking Buildbucket for the build status
[20:26:12.666] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:12.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:125:0) after 1m0s
[20:27:12.668] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:125:0)
[20:27:12.668] Timer tick, asking Buildbucket for the build status
[20:27:13.218] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:13.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:126:0) after 1m0s
[20:28:13.247] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:126:0)
[20:28:13.247] Timer tick, asking Buildbucket for the build status
[20:28:13.391] Build 8910924566489550464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:13.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9076354628479683008:127:0) after 1m0s
[20:28:59.080] Received PubSub notification, asking Buildbucket for the build status
[20:29:01.027] Build 8910924566489550464: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:29:01.027] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1560284935777466",
"created_by": "project:chromium",
"created_ts": "1560277127713670",
"failure_reason": "BUILD_FAILURE",
"id": "8910924566489550464",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"683f55dc98aada8fb5830654b63a7daca1246a9b\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_chrome_unittests (iPhone 6s iOS 11.4.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\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 12548, \"got_angle_revision\": \"9aa865a6f9885fce602e9b637a18fb124ce9d372\", \"got_dawn_revision\": \"903fc2b049cbef83ebe87cd007cf826ce33bfe55\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"683f55dc98aada8fb5830654b63a7daca1246a9b\", \"got_revision_cp\": \"refs/heads/master@{#668056}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"87666016b1999202aada8915ff5c67215ca72801\", \"got_v8_revision_cp\": \"refs/heads/7.7.44@{#1}\", \"got_webrtc_revision\": \"a7d70ab0febb918f463e4d8538ef730b18e61a72\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28223}\", \"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\": \"683f55dc98aada8fb5830654b63a7daca1246a9b\", \"swarm_hashes\": {\"0\": \"08bfbdff8cfa29a94f738b60d0d58447b2d4c0a8\", \"1\": \"9d0269650ee4d9c957aaede65e299977f1aa4674\", \"10\": \"d5fe664ef129ce91c5305b6820345a7218daceab\", \"11\": \"679235194f848b4242bb56ab71cf420b7b3a3708\", \"12\": \"d278ac8ae135167475d80192df34f912d21c779e\", \"13\": \"8abcc5322f1fcb66a3fab9f1254a22444709c61f\", \"14\": \"a872197d8f8af884945b50aefeca9a384a7b0d97\", \"15\": \"96f31680b58e48a274054598fed2e66cb68a9986\", \"16\": \"41c0e349f24b8726fc0f8d48e2757e0b2c523449\", \"2\": \"5db0d29e9d54bd707d25c0a426ac4e3124f63ed6\", \"3\": \"efde231ef855894cc4038b9e36e6c03f5318d624\", \"4\": \"9881d0b0839b4634f5d3a377881b53e5e10a92ae\", \"5\": \"0069e0d9fa983ccf107fb2aef3b02f37e31fa95c\", \"6\": \"3b3c53d20ee8c4e54c95f294c5905611d4892561\", \"7\": \"ee0f5fe76276a43ccb0111b47f04a9f29f68993a\", \"8\": \"385a4e5242cd2f0938c0cfcc064aeffcdc8751b8\", \"9\": \"560a41c559b740619e82382d0bb6c02d2cc79bfa\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build282-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4332-2f8e532\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_chrome_unittests (iPhone 6s iOS 11.4.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1560277261563963",
"status": "COMPLETED",
"status_changed_ts": "1560277262325847",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12548",
"builder:ToTiOSDevice",
"buildset:commit/git/683f55dc98aada8fb5830654b63a7daca1246a9b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/683f55dc98aada8fb5830654b63a7daca1246a9b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076354628479683008",
"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/8910924566489550464/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:ios/unified_builder_tester",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4560951f7a301010",
"user_agent:luci-scheduler"
],
"updated_ts": "1560284937326498",
"url": "https://ci.chromium.org/b/8910924566489550464",
"utcnow_ts": "1560284940753138"
}
}
[20:29:01.027] Invocation finished in 2h10m14.596233613s with status FAILED