[19:50:48.332] New invocation is queued and will start shortly
[19:50:49.417] Starting the invocation (attempt 1)
[19:50:49.462] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:50:49.462] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:50:49.462] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9074627496010366000",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"5a55bb78c4e7f95c28999a851c4316d2eb25f3f0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9074627496010366000",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/5a55bb78c4e7f95c28999a851c4316d2eb25f3f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5a55bb78c4e7f95c28999a851c4316d2eb25f3f0",
"gitiles_ref:refs/heads/master"
]
}
[19:50:50.175] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1561924249607779",
"id": "8909197434002541680",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"5a55bb78c4e7f95c28999a851c4316d2eb25f3f0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1561924250060396",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12796",
"builder:ToTiOSDevice",
"buildset:commit/git/5a55bb78c4e7f95c28999a851c4316d2eb25f3f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5a55bb78c4e7f95c28999a851c4316d2eb25f3f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074627496010366000",
"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/8909197434002541680/+/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": "1561924250060487",
"url": "https://ci.chromium.org/b/8909197434002541680",
"utcnow_ts": "1561924250166971"
}
}
[19:50:50.175] Task URL: https://ci.chromium.org/b/8909197434002541680
[19:50:50.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:2:0) after 1m0s
[19:51:50.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:2:0)
[19:51:50.177] Timer tick, asking Buildbucket for the build status
[19:51:50.320] Build 8909197434002541680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:50.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:3:0) after 1m0s
[19:52:50.343] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:3:0)
[19:52:50.343] Timer tick, asking Buildbucket for the build status
[19:52:50.653] Build 8909197434002541680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:50.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:4:0) after 1m0s
[19:52:59.168] Received PubSub notification, asking Buildbucket for the build status
[19:52:59.285] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:50.677] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:4:0)
[19:53:50.677] Timer tick, asking Buildbucket for the build status
[19:53:51.424] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:51.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:6:0) after 1m0s
[19:54:51.527] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:6:0)
[19:54:51.527] Timer tick, asking Buildbucket for the build status
[19:54:51.680] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:51.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:7:0) after 1m0s
[19:55:51.799] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:7:0)
[19:55:51.799] Timer tick, asking Buildbucket for the build status
[19:55:51.923] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:51.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:8:0) after 1m0s
[19:56:51.960] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:8:0)
[19:56:51.960] Timer tick, asking Buildbucket for the build status
[19:56:52.239] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:52.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:9:0) after 1m0s
[19:57:52.290] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:9:0)
[19:57:52.290] Timer tick, asking Buildbucket for the build status
[19:57:52.409] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:52.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:10:0) after 1m0s
[19:58:52.436] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:10:0)
[19:58:52.436] Timer tick, asking Buildbucket for the build status
[19:58:52.680] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:52.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:11:0) after 1m0s
[19:59:52.704] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:11:0)
[19:59:52.704] Timer tick, asking Buildbucket for the build status
[19:59:52.844] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:52.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:12:0) after 1m0s
[20:00:52.999] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:12:0)
[20:00:52.999] Timer tick, asking Buildbucket for the build status
[20:00:53.328] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:53.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:13:0) after 1m0s
[20:01:53.506] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:13:0)
[20:01:53.506] Timer tick, asking Buildbucket for the build status
[20:01:53.710] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:53.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:14:0) after 1m0s
[20:02:53.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:14:0)
[20:02:53.740] Timer tick, asking Buildbucket for the build status
[20:02:54.040] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:54.040] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:15:0) after 1m0s
[20:03:55.503] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:15:0)
[20:03:55.503] Timer tick, asking Buildbucket for the build status
[20:03:55.753] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:55.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:16:0) after 1m0s
[20:04:56.196] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:16:0)
[20:04:56.196] Timer tick, asking Buildbucket for the build status
[20:04:56.576] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:56.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:17:0) after 1m0s
[20:05:56.812] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:17:0)
[20:05:56.812] Timer tick, asking Buildbucket for the build status
[20:05:57.169] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:57.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:18:0) after 1m0s
[20:06:57.430] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:18:0)
[20:06:57.430] Timer tick, asking Buildbucket for the build status
[20:06:57.951] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:57.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:19:0) after 1m0s
[20:07:58.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:19:0)
[20:07:58.218] Timer tick, asking Buildbucket for the build status
[20:07:58.442] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:58.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:20:0) after 1m0s
[20:08:58.567] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:20:0)
[20:08:58.567] Timer tick, asking Buildbucket for the build status
[20:08:58.679] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:58.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:21:0) after 1m0s
[20:09:59.045] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:21:0)
[20:09:59.045] Timer tick, asking Buildbucket for the build status
[20:09:59.168] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:59.168] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:22:0) after 1m0s
[20:10:59.254] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:22:0)
[20:10:59.254] Timer tick, asking Buildbucket for the build status
[20:10:59.514] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:59.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:23:0) after 1m0s
[20:12:00.482] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:23:0)
[20:12:00.482] Timer tick, asking Buildbucket for the build status
[20:12:02.136] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:02.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:24:0) after 1m0s
[20:13:02.319] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:24:0)
[20:13:02.319] Timer tick, asking Buildbucket for the build status
[20:13:02.997] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:02.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:25:0) after 1m0s
[20:14:03.127] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:25:0)
[20:14:03.127] Timer tick, asking Buildbucket for the build status
[20:14:04.981] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:04.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:26:0) after 1m0s
[20:15:05.456] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:26:0)
[20:15:05.456] Timer tick, asking Buildbucket for the build status
[20:15:07.045] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:07.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:27:0) after 1m0s
[20:16:07.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:27:0)
[20:16:07.375] Timer tick, asking Buildbucket for the build status
[20:16:07.512] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:07.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:28:0) after 1m0s
[20:17:07.639] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:28:0)
[20:17:07.639] Timer tick, asking Buildbucket for the build status
[20:17:07.790] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:07.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:29:0) after 1m0s
[20:18:07.817] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:29:0)
[20:18:07.817] Timer tick, asking Buildbucket for the build status
[20:18:08.153] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:08.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:30:0) after 1m0s
[20:19:08.213] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:30:0)
[20:19:08.213] Timer tick, asking Buildbucket for the build status
[20:19:08.978] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:08.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:31:0) after 1m0s
[20:20:09.109] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:31:0)
[20:20:09.109] Timer tick, asking Buildbucket for the build status
[20:20:09.250] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:09.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:32:0) after 1m0s
[20:21:09.401] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:32:0)
[20:21:09.401] Timer tick, asking Buildbucket for the build status
[20:21:09.648] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:09.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:33:0) after 1m0s
[20:22:09.828] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:33:0)
[20:22:09.828] Timer tick, asking Buildbucket for the build status
[20:22:10.316] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:10.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:34:0) after 1m0s
[20:23:10.419] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:34:0)
[20:23:10.419] Timer tick, asking Buildbucket for the build status
[20:23:11.850] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:11.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:35:0) after 1m0s
[20:24:11.873] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:35:0)
[20:24:11.873] Timer tick, asking Buildbucket for the build status
[20:24:12.235] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:12.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:36:0) after 1m0s
[20:25:12.259] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:36:0)
[20:25:12.259] Timer tick, asking Buildbucket for the build status
[20:25:12.418] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:12.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:37:0) after 1m0s
[20:26:12.441] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:37:0)
[20:26:12.441] Timer tick, asking Buildbucket for the build status
[20:26:12.559] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:12.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:38:0) after 1m0s
[20:27:12.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:38:0)
[20:27:12.589] Timer tick, asking Buildbucket for the build status
[20:27:12.836] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:12.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:39:0) after 1m0s
[20:28:12.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:39:0)
[20:28:12.927] Timer tick, asking Buildbucket for the build status
[20:28:13.294] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:13.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:40:0) after 1m0s
[20:29:13.399] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:40:0)
[20:29:13.399] Timer tick, asking Buildbucket for the build status
[20:29:14.068] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:14.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:41:0) after 1m0s
[20:30:14.352] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:41:0)
[20:30:14.352] Timer tick, asking Buildbucket for the build status
[20:30:14.832] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:14.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:42:0) after 1m0s
[20:31:15.310] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:42:0)
[20:31:15.310] Timer tick, asking Buildbucket for the build status
[20:31:15.502] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:15.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:43:0) after 1m0s
[20:32:15.718] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:43:0)
[20:32:15.718] Timer tick, asking Buildbucket for the build status
[20:32:15.881] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:15.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:44:0) after 1m0s
[20:33:17.485] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:44:0)
[20:33:17.485] Timer tick, asking Buildbucket for the build status
[20:33:17.705] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:17.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:45:0) after 1m0s
[20:34:18.046] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:45:0)
[20:34:18.046] Timer tick, asking Buildbucket for the build status
[20:34:18.352] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:18.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:46:0) after 1m0s
[20:35:18.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:46:0)
[20:35:18.938] Timer tick, asking Buildbucket for the build status
[20:35:19.592] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:19.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:47:0) after 1m0s
[20:36:19.876] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:47:0)
[20:36:19.876] Timer tick, asking Buildbucket for the build status
[20:36:20.086] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:20.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:48:0) after 1m0s
[20:37:20.504] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:48:0)
[20:37:20.504] Timer tick, asking Buildbucket for the build status
[20:37:20.958] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:20.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:49:0) after 1m0s
[20:38:20.982] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:49:0)
[20:38:20.982] Timer tick, asking Buildbucket for the build status
[20:38:21.123] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:21.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:50:0) after 1m0s
[20:39:21.206] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:50:0)
[20:39:21.206] Timer tick, asking Buildbucket for the build status
[20:39:21.853] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:21.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:51:0) after 1m0s
[20:40:22.074] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:51:0)
[20:40:22.074] Timer tick, asking Buildbucket for the build status
[20:40:22.315] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:22.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:52:0) after 1m0s
[20:41:22.542] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:52:0)
[20:41:22.542] Timer tick, asking Buildbucket for the build status
[20:41:22.779] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:22.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:53:0) after 1m0s
[20:42:22.801] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:53:0)
[20:42:22.801] Timer tick, asking Buildbucket for the build status
[20:42:22.926] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:22.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:54:0) after 1m0s
[20:43:22.961] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:54:0)
[20:43:22.961] Timer tick, asking Buildbucket for the build status
[20:43:23.292] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:23.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:55:0) after 1m0s
[20:44:23.448] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:55:0)
[20:44:23.448] Timer tick, asking Buildbucket for the build status
[20:44:23.817] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:23.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:56:0) after 1m0s
[20:45:23.959] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:56:0)
[20:45:23.959] Timer tick, asking Buildbucket for the build status
[20:45:24.456] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:24.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:57:0) after 1m0s
[20:46:24.469] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:57:0)
[20:46:24.469] Timer tick, asking Buildbucket for the build status
[20:46:24.611] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:24.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:58:0) after 1m0s
[20:47:24.685] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:58:0)
[20:47:24.685] Timer tick, asking Buildbucket for the build status
[20:47:24.953] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:24.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:59:0) after 1m0s
[20:48:34.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:59:0)
[20:48:34.860] Timer tick, asking Buildbucket for the build status
[20:48:35.252] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:35.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:60:0) after 1m0s
[20:49:35.267] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:60:0)
[20:49:35.267] Timer tick, asking Buildbucket for the build status
[20:49:35.588] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:35.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:61:0) after 1m0s
[20:50:35.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:61:0)
[20:50:35.675] Timer tick, asking Buildbucket for the build status
[20:50:35.908] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:35.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:62:0) after 1m0s
[20:51:35.941] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:62:0)
[20:51:35.941] Timer tick, asking Buildbucket for the build status
[20:51:36.111] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:36.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:63:0) after 1m0s
[20:52:36.139] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:63:0)
[20:52:36.139] Timer tick, asking Buildbucket for the build status
[20:52:36.370] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:36.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:64:0) after 1m0s
[20:53:36.370] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:64:0)
[20:53:36.370] Timer tick, asking Buildbucket for the build status
[20:53:37.153] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:37.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:65:0) after 1m0s
[20:54:37.213] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:65:0)
[20:54:37.213] Timer tick, asking Buildbucket for the build status
[20:54:37.840] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:37.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:66:0) after 1m0s
[20:55:37.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:66:0)
[20:55:37.909] Timer tick, asking Buildbucket for the build status
[20:55:38.115] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:38.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:67:0) after 1m0s
[20:56:38.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:67:0)
[20:56:38.138] Timer tick, asking Buildbucket for the build status
[20:56:38.702] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:38.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:68:0) after 1m0s
[20:57:38.723] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:68:0)
[20:57:38.723] Timer tick, asking Buildbucket for the build status
[20:57:39.954] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:39.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:69:0) after 1m0s
[20:58:40.023] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:69:0)
[20:58:40.023] Timer tick, asking Buildbucket for the build status
[20:58:40.582] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:40.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:70:0) after 1m0s
[20:59:40.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:70:0)
[20:59:40.603] Timer tick, asking Buildbucket for the build status
[20:59:41.046] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:41.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:71:0) after 1m0s
[21:00:41.023] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:71:0)
[21:00:41.023] Timer tick, asking Buildbucket for the build status
[21:00:41.296] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:41.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:72:0) after 1m0s
[21:01:41.464] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:72:0)
[21:01:41.464] Timer tick, asking Buildbucket for the build status
[21:01:41.650] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:41.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:73:0) after 1m0s
[21:02:41.683] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:73:0)
[21:02:41.683] Timer tick, asking Buildbucket for the build status
[21:02:41.853] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:41.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:74:0) after 1m0s
[21:03:41.930] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:74:0)
[21:03:41.930] Timer tick, asking Buildbucket for the build status
[21:03:42.748] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:42.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:75:0) after 1m0s
[21:04:42.839] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:75:0)
[21:04:42.839] Timer tick, asking Buildbucket for the build status
[21:04:43.052] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:43.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:76:0) after 1m0s
[21:05:43.113] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:76:0)
[21:05:43.113] Timer tick, asking Buildbucket for the build status
[21:05:43.566] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:43.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:77:0) after 1m0s
[21:06:43.581] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:77:0)
[21:06:43.582] Timer tick, asking Buildbucket for the build status
[21:06:44.143] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:44.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:78:0) after 1m0s
[21:07:44.176] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:78:0)
[21:07:44.176] Timer tick, asking Buildbucket for the build status
[21:07:45.019] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:45.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:79:0) after 1m0s
[21:08:45.042] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:79:0)
[21:08:45.042] Timer tick, asking Buildbucket for the build status
[21:08:45.323] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:45.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:80:0) after 1m0s
[21:09:45.418] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:80:0)
[21:09:45.418] Timer tick, asking Buildbucket for the build status
[21:09:45.552] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:45.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:81:0) after 1m0s
[21:10:45.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:81:0)
[21:10:45.976] Timer tick, asking Buildbucket for the build status
[21:10:46.840] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:46.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:82:0) after 1m0s
[21:11:46.963] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:82:0)
[21:11:46.963] Timer tick, asking Buildbucket for the build status
[21:11:48.367] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:48.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:83:0) after 1m0s
[21:12:48.714] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:83:0)
[21:12:48.714] Timer tick, asking Buildbucket for the build status
[21:12:48.941] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:48.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:84:0) after 1m0s
[21:13:49.026] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:84:0)
[21:13:49.026] Timer tick, asking Buildbucket for the build status
[21:13:49.818] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:49.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:85:0) after 1m0s
[21:14:49.957] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:85:0)
[21:14:49.957] Timer tick, asking Buildbucket for the build status
[21:14:50.122] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:50.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:86:0) after 1m0s
[21:15:50.246] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:86:0)
[21:15:50.246] Timer tick, asking Buildbucket for the build status
[21:15:50.526] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:50.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:87:0) after 1m0s
[21:16:50.606] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:87:0)
[21:16:50.606] Timer tick, asking Buildbucket for the build status
[21:16:51.385] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:51.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:88:0) after 1m0s
[21:17:51.485] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:88:0)
[21:17:51.485] Timer tick, asking Buildbucket for the build status
[21:17:51.822] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:51.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:89:0) after 1m0s
[21:18:51.844] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:89:0)
[21:18:51.844] Timer tick, asking Buildbucket for the build status
[21:18:52.007] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:52.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:90:0) after 1m0s
[21:19:52.118] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:90:0)
[21:19:52.118] Timer tick, asking Buildbucket for the build status
[21:19:52.348] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:52.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:91:0) after 1m0s
[21:20:52.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:91:0)
[21:20:52.465] Timer tick, asking Buildbucket for the build status
[21:20:52.633] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:52.633] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:92:0) after 1m0s
[21:21:52.659] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:92:0)
[21:21:52.659] Timer tick, asking Buildbucket for the build status
[21:21:54.923] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:54.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:93:0) after 1m0s
[21:22:54.952] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:93:0)
[21:22:54.952] Timer tick, asking Buildbucket for the build status
[21:22:55.223] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:55.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:94:0) after 1m0s
[21:23:55.272] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:94:0)
[21:23:55.272] Timer tick, asking Buildbucket for the build status
[21:23:55.431] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:55.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:95:0) after 1m0s
[21:24:55.459] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:95:0)
[21:24:55.459] Timer tick, asking Buildbucket for the build status
[21:24:55.652] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:55.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:96:0) after 1m0s
[21:25:55.691] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:96:0)
[21:25:55.691] Timer tick, asking Buildbucket for the build status
[21:25:55.859] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:55.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:97:0) after 1m0s
[21:26:55.941] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:97:0)
[21:26:55.941] Timer tick, asking Buildbucket for the build status
[21:26:56.552] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:56.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:98:0) after 1m0s
[21:27:56.703] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:98:0)
[21:27:56.703] Timer tick, asking Buildbucket for the build status
[21:27:57.403] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:57.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:99:0) after 1m0s
[21:28:57.501] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:99:0)
[21:28:57.501] Timer tick, asking Buildbucket for the build status
[21:28:57.748] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:57.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:100:0) after 1m0s
[21:29:57.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:100:0)
[21:29:57.860] Timer tick, asking Buildbucket for the build status
[21:29:58.062] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:58.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:101:0) after 1m0s
[21:30:58.106] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:101:0)
[21:30:58.106] Timer tick, asking Buildbucket for the build status
[21:30:58.596] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:58.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:102:0) after 1m0s
[21:31:58.658] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:102:0)
[21:31:58.658] Timer tick, asking Buildbucket for the build status
[21:32:00.388] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:00.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:103:0) after 1m0s
[21:33:00.439] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:103:0)
[21:33:00.439] Timer tick, asking Buildbucket for the build status
[21:33:00.604] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:00.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:104:0) after 1m0s
[21:34:00.662] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:104:0)
[21:34:00.662] Timer tick, asking Buildbucket for the build status
[21:34:01.924] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:01.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:105:0) after 1m0s
[21:35:01.954] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:105:0)
[21:35:01.954] Timer tick, asking Buildbucket for the build status
[21:35:02.986] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:02.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:106:0) after 1m0s
[21:36:03.013] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:106:0)
[21:36:03.013] Timer tick, asking Buildbucket for the build status
[21:36:03.564] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:03.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:107:0) after 1m0s
[21:37:03.620] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:107:0)
[21:37:03.620] Timer tick, asking Buildbucket for the build status
[21:37:04.451] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:04.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:108:0) after 1m0s
[21:38:04.513] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:108:0)
[21:38:04.513] Timer tick, asking Buildbucket for the build status
[21:38:05.863] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:05.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:109:0) after 1m0s
[21:39:05.883] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:109:0)
[21:39:05.883] Timer tick, asking Buildbucket for the build status
[21:39:09.278] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:09.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:110:0) after 1m0s
[21:40:09.307] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:110:0)
[21:40:09.307] Timer tick, asking Buildbucket for the build status
[21:40:09.760] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:09.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:111:0) after 1m0s
[21:41:09.885] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:111:0)
[21:41:09.885] Timer tick, asking Buildbucket for the build status
[21:41:12.073] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:12.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:112:0) after 1m0s
[21:42:12.096] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:112:0)
[21:42:12.096] Timer tick, asking Buildbucket for the build status
[21:42:13.017] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:13.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:113:0) after 1m0s
[21:43:13.050] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:113:0)
[21:43:13.050] Timer tick, asking Buildbucket for the build status
[21:43:13.185] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:13.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:114:0) after 1m0s
[21:44:13.212] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:114:0)
[21:44:13.213] Timer tick, asking Buildbucket for the build status
[21:44:13.455] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:13.455] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:115:0) after 1m0s
[21:45:13.481] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:115:0)
[21:45:13.481] Timer tick, asking Buildbucket for the build status
[21:45:13.653] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:13.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:116:0) after 1m0s
[21:46:13.678] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:116:0)
[21:46:13.678] Timer tick, asking Buildbucket for the build status
[21:46:13.992] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:13.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:117:0) after 1m0s
[21:47:14.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:117:0)
[21:47:14.115] Timer tick, asking Buildbucket for the build status
[21:47:15.454] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:15.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:118:0) after 1m0s
[21:48:15.907] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:118:0)
[21:48:15.907] Timer tick, asking Buildbucket for the build status
[21:48:17.988] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:17.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:119:0) after 1m0s
[21:49:18.139] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:119:0)
[21:49:18.139] Timer tick, asking Buildbucket for the build status
[21:49:18.715] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:18.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:120:0) after 1m0s
[21:50:18.768] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:120:0)
[21:50:18.768] Timer tick, asking Buildbucket for the build status
[21:50:19.549] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:19.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:121:0) after 1m0s
[21:51:19.919] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:121:0)
[21:51:19.919] Timer tick, asking Buildbucket for the build status
[21:51:20.300] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:20.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:122:0) after 1m0s
[21:52:20.329] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:122:0)
[21:52:20.329] Timer tick, asking Buildbucket for the build status
[21:52:20.792] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:20.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:123:0) after 1m0s
[21:53:21.015] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:123:0)
[21:53:21.015] Timer tick, asking Buildbucket for the build status
[21:53:21.511] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:21.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:124:0) after 1m0s
[21:54:21.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:124:0)
[21:54:21.726] Timer tick, asking Buildbucket for the build status
[21:54:22.461] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:22.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:125:0) after 1m0s
[21:55:22.490] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:125:0)
[21:55:22.490] Timer tick, asking Buildbucket for the build status
[21:55:22.996] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:22.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:126:0) after 1m0s
[21:56:23.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:126:0)
[21:56:23.218] Timer tick, asking Buildbucket for the build status
[21:56:23.435] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:23.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:127:0) after 1m0s
[21:57:23.772] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:127:0)
[21:57:23.773] Timer tick, asking Buildbucket for the build status
[21:57:24.935] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:24.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:128:0) after 1m0s
[21:58:26.235] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:128:0)
[21:58:26.235] Timer tick, asking Buildbucket for the build status
[21:58:26.438] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:26.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:129:0) after 1m0s
[21:59:27.475] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:129:0)
[21:59:27.475] Timer tick, asking Buildbucket for the build status
[21:59:27.627] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:27.627] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:130:0) after 1m0s
[22:00:27.638] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:130:0)
[22:00:27.638] Timer tick, asking Buildbucket for the build status
[22:00:28.155] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:28.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:131:0) after 1m0s
[22:01:28.262] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:131:0)
[22:01:28.262] Timer tick, asking Buildbucket for the build status
[22:01:28.458] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:28.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:132:0) after 1m0s
[22:02:28.723] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:132:0)
[22:02:28.723] Timer tick, asking Buildbucket for the build status
[22:02:29.328] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:29.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:133:0) after 1m0s
[22:03:29.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:133:0)
[22:03:29.409] Timer tick, asking Buildbucket for the build status
[22:03:30.106] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:30.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:134:0) after 1m0s
[22:04:30.331] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:134:0)
[22:04:30.331] Timer tick, asking Buildbucket for the build status
[22:04:30.528] Build 8909197434002541680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:30.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9074627496010366000:135:0) after 1m0s
[22:05:24.677] Received PubSub notification, asking Buildbucket for the build status
[22:05:24.819] Build 8909197434002541680: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:05:24.819] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1561932321416297",
"created_by": "project:chromium",
"created_ts": "1561924249607779",
"failure_reason": "BUILD_FAILURE",
"id": "8909197434002541680",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"5a55bb78c4e7f95c28999a851c4316d2eb25f3f0\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed base_unittests (iPhone 6s iOS 11.4.1), ios_web_view_inttests (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\": 12796, \"got_angle_revision\": \"f116aa9c158b91bc966ef0394d666da4b3e7bcb6\", \"got_dawn_revision\": \"eee3e41c554257a0ece66e70b2b4e1390ffa6ab0\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"5a55bb78c4e7f95c28999a851c4316d2eb25f3f0\", \"got_revision_cp\": \"refs/heads/master@{#673618}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"45ddaacef4d3cd90c58d766380fc1f418f998cd2\", \"got_v8_revision_cp\": \"refs/heads/7.7.166@{#1}\", \"got_webrtc_revision\": \"2ce1da53283cd87219fcd111dcf2c60eb613c79f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28422}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"ios/unified_builder_tester\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"5a55bb78c4e7f95c28999a851c4316d2eb25f3f0\", \"swarm_hashes\": {\"0\": \"212de94413619c26db4e40d3aca79d24222f7cc8\", \"1\": \"6e0e14fef87a3629a1f28e9ea97c1f7e4965cc55\", \"10\": \"36bf038f4fa750d03711e93d0d0a46360f3747e5\", \"11\": \"e2e7a30fc914958fd611bedf728423fc5d110451\", \"12\": \"c4f35467f7c10954a9f3f741a73a340335e049be\", \"13\": \"481f053c1f5da18160cedc0e739317fbb46313b4\", \"14\": \"ad69ccb5b5b732a801878712ad49e0ec437448d6\", \"15\": \"415960befea56af4222f46a98317072d872ae3dd\", \"16\": \"19516b3832b1bcc03e2782483b6b89c5282fdacc\", \"2\": \"cac2a139a5548395ddabf532340f322fcd6b3bad\", \"3\": \"b39afa4d3b88ed186d49d6eabd0297e4fb0b4606\", \"4\": \"df068354d75785bf706892ec53c6548e4d6cbdfe\", \"5\": \"452bc7b03eba985ad43001aa8da4304c8c77b6c0\", \"6\": \"b40e95c04293991c557ef2be8e13b64486aede14\", \"7\": \"b229e9aef3cd20bbb645f0271bb3fe1f15d23285\", \"8\": \"b394d2a0f8821be1213e5eb216f1be701d5c22ff\", \"9\": \"c5a8352880772534a2bf1340b6fbd925fce410a8\"}}, \"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\": [\"4351-b85b41c\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed base_unittests (iPhone 6s iOS 11.4.1), ios_web_view_inttests (iPhone 6s iOS 11.4.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1561924378461165",
"status": "COMPLETED",
"status_changed_ts": "1561924378767770",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/12796",
"builder:ToTiOSDevice",
"buildset:commit/git/5a55bb78c4e7f95c28999a851c4316d2eb25f3f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5a55bb78c4e7f95c28999a851c4316d2eb25f3f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074627496010366000",
"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/8909197434002541680/+/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:45c2c2331d4a7210",
"user_agent:luci-scheduler"
],
"updated_ts": "1561932321541984",
"url": "https://ci.chromium.org/b/8909197434002541680",
"utcnow_ts": "1561932324811685"
}
}
[22:05:24.819] Invocation finished in 2h14m36.510876207s with status FAILED