[03:24:42.495] New invocation is queued and will start shortly
[03:24:43.655] Starting the invocation (attempt 1)
[03:24:43.712] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:24:43.712] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:24:43.713] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9077951026670400576",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"d301cb6d75cb7a88ee183334c204caea2f409ea9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9077951026670400576",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/d301cb6d75cb7a88ee183334c204caea2f409ea9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d301cb6d75cb7a88ee183334c204caea2f409ea9",
"gitiles_ref:refs/heads/master"
]
}
[03:24:45.801] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1558754684550055",
"id": "8912520963851892928",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d301cb6d75cb7a88ee183334c204caea2f409ea9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1558754685520539",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/7883",
"builder:ToTiOS",
"buildset:commit/git/d301cb6d75cb7a88ee183334c204caea2f409ea9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d301cb6d75cb7a88ee183334c204caea2f409ea9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077951026670400576",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8912520963851892928/+/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": "1558754685526021",
"url": "https://ci.chromium.org/b/8912520963851892928",
"utcnow_ts": "1558754685775795"
}
}
[03:24:45.801] Task URL: https://ci.chromium.org/b/8912520963851892928
[03:24:45.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:2:0) after 1m0s
[03:25:45.846] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:2:0)
[03:25:45.846] Timer tick, asking Buildbucket for the build status
[03:25:46.385] Build 8912520963851892928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:25:46.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:3:0) after 1m0s
[03:26:46.389] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:3:0)
[03:26:46.389] Timer tick, asking Buildbucket for the build status
[03:26:47.263] Build 8912520963851892928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:26:47.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:4:0) after 1m0s
[03:27:26.695] Received PubSub notification, asking Buildbucket for the build status
[03:27:26.874] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:47.335] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:4:0)
[03:27:47.335] Timer tick, asking Buildbucket for the build status
[03:27:48.962] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:48.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:6:0) after 1m0s
[03:28:49.258] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:6:0)
[03:28:49.258] Timer tick, asking Buildbucket for the build status
[03:28:49.689] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:49.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:7:0) after 1m0s
[03:29:49.758] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:7:0)
[03:29:49.758] Timer tick, asking Buildbucket for the build status
[03:29:49.869] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:49.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:8:0) after 1m0s
[03:30:49.885] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:8:0)
[03:30:49.885] Timer tick, asking Buildbucket for the build status
[03:30:50.589] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:50.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:9:0) after 1m0s
[03:31:50.635] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:9:0)
[03:31:50.635] Timer tick, asking Buildbucket for the build status
[03:31:50.747] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:50.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:10:0) after 1m0s
[03:32:50.859] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:10:0)
[03:32:50.859] Timer tick, asking Buildbucket for the build status
[03:32:51.393] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:51.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:11:0) after 1m0s
[03:33:51.427] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:11:0)
[03:33:51.427] Timer tick, asking Buildbucket for the build status
[03:33:51.653] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:51.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:12:0) after 1m0s
[03:34:51.776] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:12:0)
[03:34:51.776] Timer tick, asking Buildbucket for the build status
[03:34:52.583] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:52.583] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:13:0) after 1m0s
[03:35:52.603] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:13:0)
[03:35:52.603] Timer tick, asking Buildbucket for the build status
[03:35:53.233] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:53.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:14:0) after 1m0s
[03:36:53.433] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:14:0)
[03:36:53.433] Timer tick, asking Buildbucket for the build status
[03:36:53.722] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:53.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:15:0) after 1m0s
[03:37:53.791] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:15:0)
[03:37:53.791] Timer tick, asking Buildbucket for the build status
[03:37:54.397] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:54.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:16:0) after 1m0s
[03:38:54.481] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:16:0)
[03:38:54.481] Timer tick, asking Buildbucket for the build status
[03:38:54.859] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:54.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:17:0) after 1m0s
[03:39:54.866] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:17:0)
[03:39:54.866] Timer tick, asking Buildbucket for the build status
[03:39:56.851] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:56.851] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:18:0) after 1m0s
[03:40:56.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:18:0)
[03:40:56.950] Timer tick, asking Buildbucket for the build status
[03:40:57.483] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:57.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:19:0) after 1m0s
[03:41:57.553] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:19:0)
[03:41:57.553] Timer tick, asking Buildbucket for the build status
[03:41:57.846] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:57.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:20:0) after 1m0s
[03:42:57.902] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:20:0)
[03:42:57.902] Timer tick, asking Buildbucket for the build status
[03:42:59.212] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:59.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:21:0) after 1m0s
[03:43:59.230] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:21:0)
[03:43:59.230] Timer tick, asking Buildbucket for the build status
[03:43:59.785] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:59.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:22:0) after 1m0s
[03:45:00.036] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:22:0)
[03:45:00.036] Timer tick, asking Buildbucket for the build status
[03:45:00.231] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:00.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:23:0) after 1m0s
[03:46:00.295] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:23:0)
[03:46:00.295] Timer tick, asking Buildbucket for the build status
[03:46:00.412] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:00.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:24:0) after 1m0s
[03:47:00.552] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:24:0)
[03:47:00.552] Timer tick, asking Buildbucket for the build status
[03:47:00.792] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:00.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:25:0) after 1m0s
[03:48:00.860] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:25:0)
[03:48:00.860] Timer tick, asking Buildbucket for the build status
[03:48:02.270] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:02.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:26:0) after 1m0s
[03:49:02.291] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:26:0)
[03:49:02.291] Timer tick, asking Buildbucket for the build status
[03:49:05.401] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:05.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:27:0) after 1m0s
[03:50:05.423] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:27:0)
[03:50:05.423] Timer tick, asking Buildbucket for the build status
[03:50:05.733] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:05.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:28:0) after 1m0s
[03:51:05.730] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:28:0)
[03:51:05.730] Timer tick, asking Buildbucket for the build status
[03:51:05.893] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:05.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:29:0) after 1m0s
[03:52:05.968] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:29:0)
[03:52:05.968] Timer tick, asking Buildbucket for the build status
[03:52:06.567] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:06.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:30:0) after 1m0s
[03:53:06.640] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:30:0)
[03:53:06.640] Timer tick, asking Buildbucket for the build status
[03:53:07.604] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:07.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:31:0) after 1m0s
[03:54:07.657] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:31:0)
[03:54:07.657] Timer tick, asking Buildbucket for the build status
[03:54:07.981] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:07.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:32:0) after 1m0s
[03:55:08.027] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:32:0)
[03:55:08.027] Timer tick, asking Buildbucket for the build status
[03:55:08.146] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:08.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:33:0) after 1m0s
[03:56:08.216] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:33:0)
[03:56:08.216] Timer tick, asking Buildbucket for the build status
[03:56:08.335] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:08.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:34:0) after 1m0s
[03:57:08.365] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:34:0)
[03:57:08.365] Timer tick, asking Buildbucket for the build status
[03:57:08.770] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:08.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:35:0) after 1m0s
[03:58:08.965] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:35:0)
[03:58:08.965] Timer tick, asking Buildbucket for the build status
[03:58:09.273] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:09.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:36:0) after 1m0s
[03:59:09.294] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:36:0)
[03:59:09.294] Timer tick, asking Buildbucket for the build status
[03:59:09.430] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:09.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:37:0) after 1m0s
[04:00:09.519] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:37:0)
[04:00:09.519] Timer tick, asking Buildbucket for the build status
[04:00:10.493] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:10.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:38:0) after 1m0s
[04:01:10.582] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:38:0)
[04:01:10.582] Timer tick, asking Buildbucket for the build status
[04:01:11.047] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:11.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:39:0) after 1m0s
[04:02:11.141] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:39:0)
[04:02:11.141] Timer tick, asking Buildbucket for the build status
[04:02:11.981] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:11.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:40:0) after 1m0s
[04:03:12.118] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:40:0)
[04:03:12.118] Timer tick, asking Buildbucket for the build status
[04:03:12.487] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:12.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:41:0) after 1m0s
[04:04:12.557] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:41:0)
[04:04:12.557] Timer tick, asking Buildbucket for the build status
[04:04:14.597] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:14.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:42:0) after 1m0s
[04:05:14.656] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:42:0)
[04:05:14.656] Timer tick, asking Buildbucket for the build status
[04:05:14.790] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:14.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:43:0) after 1m0s
[04:06:14.815] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:43:0)
[04:06:14.815] Timer tick, asking Buildbucket for the build status
[04:06:15.316] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:15.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:44:0) after 1m0s
[04:07:15.467] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:44:0)
[04:07:15.467] Timer tick, asking Buildbucket for the build status
[04:07:15.987] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:15.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:45:0) after 1m0s
[04:08:16.137] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:45:0)
[04:08:16.137] Timer tick, asking Buildbucket for the build status
[04:08:16.440] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:16.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:46:0) after 1m0s
[04:09:16.454] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:46:0)
[04:09:16.454] Timer tick, asking Buildbucket for the build status
[04:09:16.560] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:16.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:47:0) after 1m0s
[04:10:17.105] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:47:0)
[04:10:17.105] Timer tick, asking Buildbucket for the build status
[04:10:17.271] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:17.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:48:0) after 1m0s
[04:11:17.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:48:0)
[04:11:17.623] Timer tick, asking Buildbucket for the build status
[04:11:18.857] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:18.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:49:0) after 1m0s
[04:12:19.045] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:49:0)
[04:12:19.045] Timer tick, asking Buildbucket for the build status
[04:12:21.038] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:21.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:50:0) after 1m0s
[04:13:21.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:50:0)
[04:13:21.578] Timer tick, asking Buildbucket for the build status
[04:13:21.905] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:21.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:51:0) after 1m0s
[04:14:22.164] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:51:0)
[04:14:22.164] Timer tick, asking Buildbucket for the build status
[04:14:22.365] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:22.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:52:0) after 1m0s
[04:15:22.448] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:52:0)
[04:15:22.448] Timer tick, asking Buildbucket for the build status
[04:15:23.344] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:23.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:53:0) after 1m0s
[04:16:23.373] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:53:0)
[04:16:23.373] Timer tick, asking Buildbucket for the build status
[04:16:23.470] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:23.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:54:0) after 1m0s
[04:17:23.544] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:54:0)
[04:17:23.544] Timer tick, asking Buildbucket for the build status
[04:17:23.772] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:23.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:55:0) after 1m0s
[04:18:23.956] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:55:0)
[04:18:23.956] Timer tick, asking Buildbucket for the build status
[04:18:25.423] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:25.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:56:0) after 1m0s
[04:19:25.562] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:56:0)
[04:19:25.562] Timer tick, asking Buildbucket for the build status
[04:19:27.237] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:27.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:57:0) after 1m0s
[04:20:27.571] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:57:0)
[04:20:27.571] Timer tick, asking Buildbucket for the build status
[04:20:27.726] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:27.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:58:0) after 1m0s
[04:21:27.890] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:58:0)
[04:21:27.890] Timer tick, asking Buildbucket for the build status
[04:21:30.141] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:30.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:59:0) after 1m0s
[04:22:30.298] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:59:0)
[04:22:30.298] Timer tick, asking Buildbucket for the build status
[04:22:30.648] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:30.648] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:60:0) after 1m0s
[04:23:30.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:60:0)
[04:23:30.870] Timer tick, asking Buildbucket for the build status
[04:23:31.375] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:31.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:61:0) after 1m0s
[04:24:31.397] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:61:0)
[04:24:31.397] Timer tick, asking Buildbucket for the build status
[04:24:31.524] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:31.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:62:0) after 1m0s
[04:25:31.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:62:0)
[04:25:31.543] Timer tick, asking Buildbucket for the build status
[04:25:32.307] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:32.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:63:0) after 1m0s
[04:26:32.608] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:63:0)
[04:26:32.608] Timer tick, asking Buildbucket for the build status
[04:26:32.820] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:32.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:64:0) after 1m0s
[04:27:32.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:64:0)
[04:27:32.848] Timer tick, asking Buildbucket for the build status
[04:27:33.365] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:33.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:65:0) after 1m0s
[04:28:33.430] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:65:0)
[04:28:33.430] Timer tick, asking Buildbucket for the build status
[04:28:33.759] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:33.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:66:0) after 1m0s
[04:29:33.821] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:66:0)
[04:29:33.821] Timer tick, asking Buildbucket for the build status
[04:29:34.274] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:34.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:67:0) after 1m0s
[04:30:34.360] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:67:0)
[04:30:34.360] Timer tick, asking Buildbucket for the build status
[04:30:34.536] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:34.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:68:0) after 1m0s
[04:31:34.576] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:68:0)
[04:31:34.576] Timer tick, asking Buildbucket for the build status
[04:31:36.745] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:36.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:69:0) after 1m0s
[04:32:37.094] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:69:0)
[04:32:37.094] Timer tick, asking Buildbucket for the build status
[04:32:38.081] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:38.081] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:70:0) after 1m0s
[04:33:38.104] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:70:0)
[04:33:38.104] Timer tick, asking Buildbucket for the build status
[04:33:38.272] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:38.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:71:0) after 1m0s
[04:34:38.770] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:71:0)
[04:34:38.770] Timer tick, asking Buildbucket for the build status
[04:34:38.973] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:38.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:72:0) after 1m0s
[04:35:39.200] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:72:0)
[04:35:39.200] Timer tick, asking Buildbucket for the build status
[04:35:39.463] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:39.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:73:0) after 1m0s
[04:36:39.536] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:73:0)
[04:36:39.536] Timer tick, asking Buildbucket for the build status
[04:36:39.787] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:39.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:74:0) after 1m0s
[04:37:40.041] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:74:0)
[04:37:40.041] Timer tick, asking Buildbucket for the build status
[04:37:40.191] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:40.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:75:0) after 1m0s
[04:38:40.227] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:75:0)
[04:38:40.227] Timer tick, asking Buildbucket for the build status
[04:38:41.900] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:41.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:76:0) after 1m0s
[04:39:41.922] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:76:0)
[04:39:41.922] Timer tick, asking Buildbucket for the build status
[04:39:42.677] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:42.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:77:0) after 1m0s
[04:40:42.734] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:77:0)
[04:40:42.734] Timer tick, asking Buildbucket for the build status
[04:40:44.410] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:44.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:78:0) after 1m0s
[04:41:44.489] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:78:0)
[04:41:44.489] Timer tick, asking Buildbucket for the build status
[04:41:44.604] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:44.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:79:0) after 1m0s
[04:42:44.749] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:79:0)
[04:42:44.749] Timer tick, asking Buildbucket for the build status
[04:42:44.956] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:44.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:80:0) after 1m0s
[04:43:44.994] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:80:0)
[04:43:44.994] Timer tick, asking Buildbucket for the build status
[04:43:45.227] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:45.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:81:0) after 1m0s
[04:44:45.303] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:81:0)
[04:44:45.303] Timer tick, asking Buildbucket for the build status
[04:44:46.496] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:46.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:82:0) after 1m0s
[04:45:46.569] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:82:0)
[04:45:46.569] Timer tick, asking Buildbucket for the build status
[04:45:47.104] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:47.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:83:0) after 1m0s
[04:46:47.123] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:83:0)
[04:46:47.123] Timer tick, asking Buildbucket for the build status
[04:46:47.564] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:47.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:84:0) after 1m0s
[04:47:47.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:84:0)
[04:47:47.563] Timer tick, asking Buildbucket for the build status
[04:47:48.487] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:48.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:85:0) after 1m0s
[04:48:48.515] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:85:0)
[04:48:48.515] Timer tick, asking Buildbucket for the build status
[04:48:50.051] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:50.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:86:0) after 1m0s
[04:49:50.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:86:0)
[04:49:50.079] Timer tick, asking Buildbucket for the build status
[04:49:50.171] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:50.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:87:0) after 1m0s
[04:50:50.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:87:0)
[04:50:50.342] Timer tick, asking Buildbucket for the build status
[04:50:50.471] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:50.471] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:88:0) after 1m0s
[04:51:50.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:88:0)
[04:51:50.597] Timer tick, asking Buildbucket for the build status
[04:51:52.604] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:52.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:89:0) after 1m0s
[04:52:52.627] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:89:0)
[04:52:52.627] Timer tick, asking Buildbucket for the build status
[04:52:52.835] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:52.835] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:90:0) after 1m0s
[04:53:52.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:90:0)
[04:53:52.932] Timer tick, asking Buildbucket for the build status
[04:53:54.874] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:54.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:91:0) after 1m0s
[04:54:54.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:91:0)
[04:54:54.905] Timer tick, asking Buildbucket for the build status
[04:54:55.780] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:55.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:92:0) after 1m0s
[04:55:55.804] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:92:0)
[04:55:55.804] Timer tick, asking Buildbucket for the build status
[04:55:55.976] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:55.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:93:0) after 1m0s
[04:56:56.001] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:93:0)
[04:56:56.001] Timer tick, asking Buildbucket for the build status
[04:56:56.931] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:56.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:94:0) after 1m0s
[04:57:56.953] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:94:0)
[04:57:56.953] Timer tick, asking Buildbucket for the build status
[04:57:58.323] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:58.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:95:0) after 1m0s
[04:58:58.449] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:95:0)
[04:58:58.449] Timer tick, asking Buildbucket for the build status
[04:58:58.691] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:58.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:96:0) after 1m0s
[04:59:58.925] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:96:0)
[04:59:58.925] Timer tick, asking Buildbucket for the build status
[04:59:59.079] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:59.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:97:0) after 1m0s
[05:00:59.115] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:97:0)
[05:00:59.115] Timer tick, asking Buildbucket for the build status
[05:00:59.333] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:59.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:98:0) after 1m0s
[05:01:59.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:98:0)
[05:01:59.317] Timer tick, asking Buildbucket for the build status
[05:01:59.660] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:59.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:99:0) after 1m0s
[05:02:59.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:99:0)
[05:02:59.732] Timer tick, asking Buildbucket for the build status
[05:03:00.724] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:00.724] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:100:0) after 1m0s
[05:04:00.810] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:100:0)
[05:04:00.810] Timer tick, asking Buildbucket for the build status
[05:04:02.106] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:02.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:101:0) after 1m0s
[05:05:02.231] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:101:0)
[05:05:02.231] Timer tick, asking Buildbucket for the build status
[05:05:03.848] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:03.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:102:0) after 1m0s
[05:06:03.873] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:102:0)
[05:06:03.873] Timer tick, asking Buildbucket for the build status
[05:06:04.309] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:04.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:103:0) after 1m0s
[05:07:04.346] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:103:0)
[05:07:04.346] Timer tick, asking Buildbucket for the build status
[05:07:05.577] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:05.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:104:0) after 1m0s
[05:08:05.655] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:104:0)
[05:08:05.655] Timer tick, asking Buildbucket for the build status
[05:08:05.983] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:05.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:105:0) after 1m0s
[05:09:06.023] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:105:0)
[05:09:06.023] Timer tick, asking Buildbucket for the build status
[05:09:08.440] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:08.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:106:0) after 1m0s
[05:10:08.473] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:106:0)
[05:10:08.473] Timer tick, asking Buildbucket for the build status
[05:10:08.940] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:08.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:107:0) after 1m0s
[05:11:09.018] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:107:0)
[05:11:09.018] Timer tick, asking Buildbucket for the build status
[05:11:09.260] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:09.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:108:0) after 1m0s
[05:12:09.293] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:108:0)
[05:12:09.295] Timer tick, asking Buildbucket for the build status
[05:12:09.784] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:09.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:109:0) after 1m0s
[05:13:09.816] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:109:0)
[05:13:09.816] Timer tick, asking Buildbucket for the build status
[05:13:10.123] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:10.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:110:0) after 1m0s
[05:14:10.151] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:110:0)
[05:14:10.151] Timer tick, asking Buildbucket for the build status
[05:14:12.172] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:12.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:111:0) after 1m0s
[05:15:12.350] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:111:0)
[05:15:12.350] Timer tick, asking Buildbucket for the build status
[05:15:12.439] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:12.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:112:0) after 1m0s
[05:16:12.418] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:112:0)
[05:16:12.418] Timer tick, asking Buildbucket for the build status
[05:16:15.469] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:15.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:113:0) after 1m0s
[05:17:15.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:113:0)
[05:17:15.563] Timer tick, asking Buildbucket for the build status
[05:17:15.718] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:15.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:114:0) after 1m0s
[05:18:15.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:114:0)
[05:18:15.870] Timer tick, asking Buildbucket for the build status
[05:18:16.092] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:16.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:115:0) after 1m0s
[05:19:16.226] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:115:0)
[05:19:16.226] Timer tick, asking Buildbucket for the build status
[05:19:16.900] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:16.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:116:0) after 1m0s
[05:20:16.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:116:0)
[05:20:16.932] Timer tick, asking Buildbucket for the build status
[05:20:18.337] Build 8912520963851892928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:18.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9077951026670400576:117:0) after 1m0s
[05:20:33.183] Received PubSub notification, asking Buildbucket for the build status
[05:20:34.564] Build 8912520963851892928: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:20:34.564] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1558761630946636",
"created_by": "project:chromium",
"created_ts": "1558754684550055",
"failure_reason": "BUILD_FAILURE",
"id": "8912520963851892928",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d301cb6d75cb7a88ee183334c204caea2f409ea9\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_inttests (iPhone 6s iOS 12.1).\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build284-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 7883, \"got_angle_revision\": \"40757b28bdc8bd1ac7312dd975a33f96abe87429\", \"got_dawn_revision\": \"8aa036e9e498fb99756d507fc7a6b6f7ebce6767\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"d301cb6d75cb7a88ee183334c204caea2f409ea9\", \"got_revision_cp\": \"refs/heads/master@{#663383}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"376299599eab0ec7932adb28c55209e8daf3b8d8\", \"got_v8_revision_cp\": \"refs/heads/7.6.274@{#1}\", \"got_webrtc_revision\": \"3a1b92772f661b6b52710fee27c5707bcfdda4a6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28066}\", \"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\": \"d301cb6d75cb7a88ee183334c204caea2f409ea9\", \"swarm_hashes\": {\"0\": \"608cf9d6e0f541fe80ebf90b8c538e3df42cc010\", \"1\": \"a58548b0125c1748fcc8995d44bdc39e0f3f7323\", \"10\": \"c96a95e9c1b2d4e807df0c281b86fc912a219f78\", \"11\": \"3efc749111955a5e00bc33ae721573020e3afa47\", \"12\": \"c61625fa53772687389a4bd00921ef7f5d5f2a58\", \"13\": \"0497414726ea7ad961c27ef131ed9a32836652b4\", \"14\": \"7bb86a5cdd5e901c82f750bc9e15820c94072c58\", \"15\": \"3e4badff758075279a64392332b480a8bc48dd2d\", \"16\": \"1343b4614c21618c2f437c130a89c91949b16c49\", \"2\": \"148c20395c98d6a757629d7e1e25aa7ed3a0c548\", \"3\": \"3a9019488453628aeab7fac4fdc8992c51712200\", \"4\": \"8692cbaebcea6781d3fbd914c81f5e879f5cbf2b\", \"5\": \"a493091bea866cab78922792b34bdab87f71e0a9\", \"6\": \"b71480e0ba16f90230c60878a453c15a08cba4a7\", \"7\": \"50b0c7a14ed20a646a5120da203255aee2398857\", \"8\": \"4769d8d293624a49ddcd84148eedfcf1b0b1c2e1\", \"9\": \"7c6f0cb345ab8d27ad15f7b88f5966a0f8c4cba4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_69caa34b8f39daac28a821cac2619730401d46a6479812cc34796e3bf180418a_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_10b61\"], \"cores\": [\"24\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2697_v2\"], \"gce\": [\"0\"], \"gpu\": [\"1002\", \"1002:679e\", \"1002:679e-4.0.11-3.2.8\"], \"hidpi\": [\"0\"], \"id\": [\"build284-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4303-bae210e\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1558754843899177",
"status": "COMPLETED",
"status_changed_ts": "1558754846125547",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/7883",
"builder:ToTiOS",
"buildset:commit/git/d301cb6d75cb7a88ee183334c204caea2f409ea9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d301cb6d75cb7a88ee183334c204caea2f409ea9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077951026670400576",
"scheduler_job_id:chromium/ToTiOS",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8912520963851892928/+/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:4505d67d05d11310",
"user_agent:luci-scheduler"
],
"updated_ts": "1558761632092371",
"url": "https://ci.chromium.org/b/8912520963851892928",
"utcnow_ts": "1558761634551308"
}
}
[05:20:34.564] Invocation finished in 1h55m52.086056722s with status FAILED