[00:11:44.722] New invocation is queued and will start shortly
[00:11:46.043] Starting the invocation (attempt 1)
[00:11:46.148] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:11:46.148] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:11:46.148] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9057850640327531568",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"00cd5a46cac507988559c6672424fefe31f7caf4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9057850640327531568",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/00cd5a46cac507988559c6672424fefe31f7caf4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/00cd5a46cac507988559c6672424fefe31f7caf4",
"gitiles_ref:refs/heads/master"
]
}
[00:11:47.410] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1577923906674567",
"id": "8892420577593895376",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"00cd5a46cac507988559c6672424fefe31f7caf4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577923907280279",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11765",
"builder:ToTiOS",
"buildset:commit/git/00cd5a46cac507988559c6672424fefe31f7caf4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/00cd5a46cac507988559c6672424fefe31f7caf4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057850640327531568",
"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/8892420577593895376/+/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": "1577923907280420",
"url": "https://ci.chromium.org/b/8892420577593895376",
"utcnow_ts": "1577923907401320"
}
}
[00:11:47.410] Task URL: https://ci.chromium.org/b/8892420577593895376
[00:11:47.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:2:0) after 1m0s
[00:12:58.061] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:2:0)
[00:12:58.061] Timer tick, asking Buildbucket for the build status
[00:12:59.275] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:59.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:3:0) after 1m0s
[00:12:59.553] Received PubSub notification, asking Buildbucket for the build status
[00:12:59.647] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:59.297] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:3:0)
[00:13:59.297] Timer tick, asking Buildbucket for the build status
[00:13:59.673] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:59.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:5:0) after 1m0s
[00:14:59.737] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:5:0)
[00:14:59.737] Timer tick, asking Buildbucket for the build status
[00:15:00.900] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:00.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:6:0) after 1m0s
[00:16:00.922] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:6:0)
[00:16:00.922] Timer tick, asking Buildbucket for the build status
[00:16:01.340] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:01.340] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:7:0) after 1m0s
[00:17:01.371] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:7:0)
[00:17:01.371] Timer tick, asking Buildbucket for the build status
[00:17:02.021] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:02.021] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:8:0) after 1m0s
[00:18:02.117] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:8:0)
[00:18:02.117] Timer tick, asking Buildbucket for the build status
[00:18:02.735] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:02.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:9:0) after 1m0s
[00:19:02.737] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:9:0)
[00:19:02.737] Timer tick, asking Buildbucket for the build status
[00:19:02.896] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:02.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:10:0) after 1m0s
[00:20:02.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:10:0)
[00:20:02.944] Timer tick, asking Buildbucket for the build status
[00:20:04.387] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:04.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:11:0) after 1m0s
[00:21:04.463] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:11:0)
[00:21:04.463] Timer tick, asking Buildbucket for the build status
[00:21:05.186] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:05.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:12:0) after 1m0s
[00:22:05.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:12:0)
[00:22:05.248] Timer tick, asking Buildbucket for the build status
[00:22:05.600] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:05.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:13:0) after 1m0s
[00:23:05.639] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:13:0)
[00:23:05.639] Timer tick, asking Buildbucket for the build status
[00:23:05.990] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:05.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:14:0) after 1m0s
[00:24:06.066] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:14:0)
[00:24:06.066] Timer tick, asking Buildbucket for the build status
[00:24:06.468] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:06.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:15:0) after 1m0s
[00:25:06.500] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:15:0)
[00:25:06.500] Timer tick, asking Buildbucket for the build status
[00:25:06.731] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:06.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:16:0) after 1m0s
[00:26:06.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:16:0)
[00:26:06.848] Timer tick, asking Buildbucket for the build status
[00:26:07.351] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:07.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:17:0) after 1m0s
[00:27:07.377] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:17:0)
[00:27:07.377] Timer tick, asking Buildbucket for the build status
[00:27:07.665] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:07.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:18:0) after 1m0s
[00:28:07.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:18:0)
[00:28:07.726] Timer tick, asking Buildbucket for the build status
[00:28:07.925] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:07.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:19:0) after 1m0s
[00:29:07.945] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:19:0)
[00:29:07.945] Timer tick, asking Buildbucket for the build status
[00:29:08.345] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:08.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:20:0) after 1m0s
[00:30:08.430] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:20:0)
[00:30:08.430] Timer tick, asking Buildbucket for the build status
[00:30:08.990] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:08.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:21:0) after 1m0s
[00:31:09.017] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:21:0)
[00:31:09.017] Timer tick, asking Buildbucket for the build status
[00:31:09.255] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:09.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:22:0) after 1m0s
[00:32:09.279] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:22:0)
[00:32:09.279] Timer tick, asking Buildbucket for the build status
[00:32:09.507] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:09.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:23:0) after 1m0s
[00:33:09.653] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:23:0)
[00:33:09.653] Timer tick, asking Buildbucket for the build status
[00:33:10.462] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:10.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:24:0) after 1m0s
[00:34:10.806] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:24:0)
[00:34:10.806] Timer tick, asking Buildbucket for the build status
[00:34:11.390] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:11.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:25:0) after 1m0s
[00:35:11.464] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:25:0)
[00:35:11.464] Timer tick, asking Buildbucket for the build status
[00:35:11.844] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:11.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:26:0) after 1m0s
[00:36:11.865] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:26:0)
[00:36:11.865] Timer tick, asking Buildbucket for the build status
[00:36:12.211] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:12.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:27:0) after 1m0s
[00:37:12.363] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:27:0)
[00:37:12.363] Timer tick, asking Buildbucket for the build status
[00:37:12.987] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:12.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:28:0) after 1m0s
[00:38:13.236] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:28:0)
[00:38:13.236] Timer tick, asking Buildbucket for the build status
[00:38:13.442] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:13.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:29:0) after 1m0s
[00:39:13.568] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:29:0)
[00:39:13.568] Timer tick, asking Buildbucket for the build status
[00:39:13.823] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:13.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:30:0) after 1m0s
[00:40:13.848] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:30:0)
[00:40:13.848] Timer tick, asking Buildbucket for the build status
[00:40:14.240] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:14.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:31:0) after 1m0s
[00:41:14.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:31:0)
[00:41:14.404] Timer tick, asking Buildbucket for the build status
[00:41:14.748] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:14.748] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:32:0) after 1m0s
[00:42:14.769] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:32:0)
[00:42:14.769] Timer tick, asking Buildbucket for the build status
[00:42:14.947] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:14.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:33:0) after 1m0s
[00:43:14.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:33:0)
[00:43:14.927] Timer tick, asking Buildbucket for the build status
[00:43:15.375] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:15.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:34:0) after 1m0s
[00:44:15.435] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:34:0)
[00:44:15.435] Timer tick, asking Buildbucket for the build status
[00:44:15.608] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:15.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:35:0) after 1m0s
[00:45:15.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:35:0)
[00:45:15.675] Timer tick, asking Buildbucket for the build status
[00:45:16.309] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:16.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:36:0) after 1m0s
[00:46:16.508] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:36:0)
[00:46:16.508] Timer tick, asking Buildbucket for the build status
[00:46:17.325] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:17.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:37:0) after 1m0s
[00:47:17.454] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:37:0)
[00:47:17.454] Timer tick, asking Buildbucket for the build status
[00:47:17.875] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:17.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:38:0) after 1m0s
[00:48:17.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:38:0)
[00:48:17.944] Timer tick, asking Buildbucket for the build status
[00:48:18.182] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:18.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:39:0) after 1m0s
[00:49:18.284] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:39:0)
[00:49:18.284] Timer tick, asking Buildbucket for the build status
[00:49:19.228] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:19.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:40:0) after 1m0s
[00:50:19.289] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:40:0)
[00:50:19.289] Timer tick, asking Buildbucket for the build status
[00:50:19.538] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:19.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:41:0) after 1m0s
[00:51:19.610] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:41:0)
[00:51:19.610] Timer tick, asking Buildbucket for the build status
[00:51:19.836] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:19.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:42:0) after 1m0s
[00:52:19.883] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:42:0)
[00:52:19.883] Timer tick, asking Buildbucket for the build status
[00:52:20.104] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:20.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:43:0) after 1m0s
[00:53:20.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:43:0)
[00:53:20.134] Timer tick, asking Buildbucket for the build status
[00:53:20.348] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:20.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:44:0) after 1m0s
[00:54:20.377] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:44:0)
[00:54:20.377] Timer tick, asking Buildbucket for the build status
[00:54:20.531] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:20.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:45:0) after 1m0s
[00:55:20.549] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:45:0)
[00:55:20.549] Timer tick, asking Buildbucket for the build status
[00:55:21.759] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:21.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:46:0) after 1m0s
[00:56:21.781] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:46:0)
[00:56:21.781] Timer tick, asking Buildbucket for the build status
[00:56:22.985] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:22.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:47:0) after 1m0s
[00:57:23.009] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:47:0)
[00:57:23.009] Timer tick, asking Buildbucket for the build status
[00:57:23.501] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:23.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:48:0) after 1m0s
[00:58:23.525] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:48:0)
[00:58:23.525] Timer tick, asking Buildbucket for the build status
[00:58:24.363] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:24.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:49:0) after 1m0s
[00:59:24.406] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:49:0)
[00:59:24.406] Timer tick, asking Buildbucket for the build status
[00:59:24.929] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:24.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:50:0) after 1m0s
[01:00:25.053] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:50:0)
[01:00:25.053] Timer tick, asking Buildbucket for the build status
[01:00:25.322] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:25.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:51:0) after 1m0s
[01:01:25.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:51:0)
[01:01:25.375] Timer tick, asking Buildbucket for the build status
[01:01:25.523] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:25.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:52:0) after 1m0s
[01:02:25.567] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:52:0)
[01:02:25.567] Timer tick, asking Buildbucket for the build status
[01:02:25.766] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:25.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:53:0) after 1m0s
[01:03:25.785] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:53:0)
[01:03:25.785] Timer tick, asking Buildbucket for the build status
[01:03:26.018] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:26.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:54:0) after 1m0s
[01:04:26.076] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:54:0)
[01:04:26.076] Timer tick, asking Buildbucket for the build status
[01:04:26.747] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:26.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:55:0) after 1m0s
[01:05:26.783] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:55:0)
[01:05:26.783] Timer tick, asking Buildbucket for the build status
[01:05:27.104] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:27.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:56:0) after 1m0s
[01:06:27.179] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:56:0)
[01:06:27.179] Timer tick, asking Buildbucket for the build status
[01:06:27.546] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:27.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:57:0) after 1m0s
[01:07:27.676] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:57:0)
[01:07:27.676] Timer tick, asking Buildbucket for the build status
[01:07:27.896] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:27.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:58:0) after 1m0s
[01:08:28.043] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:58:0)
[01:08:28.043] Timer tick, asking Buildbucket for the build status
[01:08:28.245] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:28.245] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:59:0) after 1m0s
[01:09:28.319] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:59:0)
[01:09:28.319] Timer tick, asking Buildbucket for the build status
[01:09:29.056] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:29.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:60:0) after 1m0s
[01:10:29.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:60:0)
[01:10:29.079] Timer tick, asking Buildbucket for the build status
[01:10:29.900] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:29.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:61:0) after 1m0s
[01:11:29.955] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:61:0)
[01:11:29.955] Timer tick, asking Buildbucket for the build status
[01:11:30.140] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:30.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:62:0) after 1m0s
[01:12:30.193] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:62:0)
[01:12:30.193] Timer tick, asking Buildbucket for the build status
[01:12:30.511] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:30.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:63:0) after 1m0s
[01:13:30.580] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:63:0)
[01:13:30.580] Timer tick, asking Buildbucket for the build status
[01:13:30.796] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:30.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:64:0) after 1m0s
[01:14:30.870] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:64:0)
[01:14:30.870] Timer tick, asking Buildbucket for the build status
[01:14:31.240] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:31.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:65:0) after 1m0s
[01:15:31.260] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:65:0)
[01:15:31.260] Timer tick, asking Buildbucket for the build status
[01:15:31.663] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:31.663] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:66:0) after 1m0s
[01:16:31.683] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:66:0)
[01:16:31.683] Timer tick, asking Buildbucket for the build status
[01:16:31.974] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:31.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:67:0) after 1m0s
[01:17:32.042] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:67:0)
[01:17:32.042] Timer tick, asking Buildbucket for the build status
[01:17:32.274] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:32.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:68:0) after 1m0s
[01:18:32.285] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:68:0)
[01:18:32.285] Timer tick, asking Buildbucket for the build status
[01:18:32.655] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:32.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:69:0) after 1m0s
[01:19:32.719] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:69:0)
[01:19:32.719] Timer tick, asking Buildbucket for the build status
[01:19:33.154] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:33.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:70:0) after 1m0s
[01:20:33.224] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:70:0)
[01:20:33.224] Timer tick, asking Buildbucket for the build status
[01:20:33.409] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:33.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:71:0) after 1m0s
[01:21:33.546] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:71:0)
[01:21:33.546] Timer tick, asking Buildbucket for the build status
[01:21:34.118] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:34.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:72:0) after 1m0s
[01:22:34.138] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:72:0)
[01:22:34.138] Timer tick, asking Buildbucket for the build status
[01:22:34.664] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:34.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:73:0) after 1m0s
[01:23:34.759] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:73:0)
[01:23:34.759] Timer tick, asking Buildbucket for the build status
[01:23:35.051] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:35.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:74:0) after 1m0s
[01:24:35.171] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:74:0)
[01:24:35.171] Timer tick, asking Buildbucket for the build status
[01:24:36.477] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:36.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:75:0) after 1m0s
[01:25:36.806] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:75:0)
[01:25:36.806] Timer tick, asking Buildbucket for the build status
[01:25:37.358] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:37.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:76:0) after 1m0s
[01:26:37.477] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:76:0)
[01:26:37.477] Timer tick, asking Buildbucket for the build status
[01:26:38.482] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:38.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:77:0) after 1m0s
[01:27:38.549] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:77:0)
[01:27:38.549] Timer tick, asking Buildbucket for the build status
[01:27:38.710] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:38.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:78:0) after 1m0s
[01:28:38.846] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:78:0)
[01:28:38.846] Timer tick, asking Buildbucket for the build status
[01:28:39.257] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:39.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:79:0) after 1m0s
[01:29:39.470] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:79:0)
[01:29:39.470] Timer tick, asking Buildbucket for the build status
[01:29:39.756] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:39.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:80:0) after 1m0s
[01:30:39.792] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:80:0)
[01:30:39.792] Timer tick, asking Buildbucket for the build status
[01:30:40.165] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:40.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:81:0) after 1m0s
[01:31:40.185] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:81:0)
[01:31:40.185] Timer tick, asking Buildbucket for the build status
[01:31:40.872] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:40.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:82:0) after 1m0s
[01:32:40.894] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:82:0)
[01:32:40.894] Timer tick, asking Buildbucket for the build status
[01:32:41.539] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:41.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:83:0) after 1m0s
[01:33:41.627] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:83:0)
[01:33:41.627] Timer tick, asking Buildbucket for the build status
[01:33:41.768] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:41.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:84:0) after 1m0s
[01:34:41.791] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:84:0)
[01:34:41.791] Timer tick, asking Buildbucket for the build status
[01:34:41.949] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:41.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:85:0) after 1m0s
[01:35:42.058] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:85:0)
[01:35:42.058] Timer tick, asking Buildbucket for the build status
[01:35:42.205] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:42.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:86:0) after 1m0s
[01:36:42.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:86:0)
[01:36:42.197] Timer tick, asking Buildbucket for the build status
[01:36:42.494] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:42.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:87:0) after 1m0s
[01:37:42.606] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:87:0)
[01:37:42.606] Timer tick, asking Buildbucket for the build status
[01:37:43.248] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:43.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:88:0) after 1m0s
[01:38:43.270] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:88:0)
[01:38:43.270] Timer tick, asking Buildbucket for the build status
[01:38:43.437] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:43.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:89:0) after 1m0s
[01:39:43.457] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:89:0)
[01:39:43.457] Timer tick, asking Buildbucket for the build status
[01:39:43.623] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:43.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:90:0) after 1m0s
[01:40:43.680] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:90:0)
[01:40:43.680] Timer tick, asking Buildbucket for the build status
[01:40:43.968] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:43.968] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:91:0) after 1m0s
[01:41:44.002] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:91:0)
[01:41:44.002] Timer tick, asking Buildbucket for the build status
[01:41:45.956] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:45.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:92:0) after 1m0s
[01:42:46.038] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:92:0)
[01:42:46.038] Timer tick, asking Buildbucket for the build status
[01:42:46.209] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:46.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:93:0) after 1m0s
[01:43:46.242] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:93:0)
[01:43:46.242] Timer tick, asking Buildbucket for the build status
[01:43:46.897] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:46.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:94:0) after 1m0s
[01:44:47.017] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:94:0)
[01:44:47.017] Timer tick, asking Buildbucket for the build status
[01:44:47.304] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:47.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:95:0) after 1m0s
[01:45:47.387] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:95:0)
[01:45:47.387] Timer tick, asking Buildbucket for the build status
[01:45:47.575] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:47.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:96:0) after 1m0s
[01:46:47.576] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:96:0)
[01:46:47.576] Timer tick, asking Buildbucket for the build status
[01:46:48.074] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:48.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:97:0) after 1m0s
[01:47:48.545] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:97:0)
[01:47:48.545] Timer tick, asking Buildbucket for the build status
[01:47:49.007] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:49.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:98:0) after 1m0s
[01:48:49.043] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:98:0)
[01:48:49.043] Timer tick, asking Buildbucket for the build status
[01:48:49.227] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:49.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:99:0) after 1m0s
[01:49:49.361] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:99:0)
[01:49:49.361] Timer tick, asking Buildbucket for the build status
[01:49:50.097] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:50.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:100:0) after 1m0s
[01:50:50.274] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:100:0)
[01:50:50.274] Timer tick, asking Buildbucket for the build status
[01:50:50.719] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:50.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:101:0) after 1m0s
[01:51:50.895] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:101:0)
[01:51:50.895] Timer tick, asking Buildbucket for the build status
[01:51:51.063] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:51.063] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:102:0) after 1m0s
[01:52:51.188] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:102:0)
[01:52:51.188] Timer tick, asking Buildbucket for the build status
[01:52:51.693] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:51.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:103:0) after 1m0s
[01:53:51.844] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:103:0)
[01:53:51.844] Timer tick, asking Buildbucket for the build status
[01:53:52.336] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:52.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:104:0) after 1m0s
[01:54:52.399] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:104:0)
[01:54:52.399] Timer tick, asking Buildbucket for the build status
[01:54:52.563] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:52.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:105:0) after 1m0s
[01:55:52.641] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:105:0)
[01:55:52.641] Timer tick, asking Buildbucket for the build status
[01:55:53.180] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:53.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:106:0) after 1m0s
[01:56:53.491] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:106:0)
[01:56:53.491] Timer tick, asking Buildbucket for the build status
[01:56:53.670] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:53.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:107:0) after 1m0s
[01:57:53.726] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:107:0)
[01:57:53.726] Timer tick, asking Buildbucket for the build status
[01:57:54.374] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:54.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:108:0) after 1m0s
[01:58:54.489] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:108:0)
[01:58:54.489] Timer tick, asking Buildbucket for the build status
[01:58:55.142] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:55.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:109:0) after 1m0s
[01:59:55.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:109:0)
[01:59:55.317] Timer tick, asking Buildbucket for the build status
[01:59:55.753] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:55.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:110:0) after 1m0s
[02:00:55.863] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:110:0)
[02:00:55.863] Timer tick, asking Buildbucket for the build status
[02:00:56.145] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:56.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:111:0) after 1m0s
[02:01:56.277] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:111:0)
[02:01:56.277] Timer tick, asking Buildbucket for the build status
[02:01:56.472] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:56.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:112:0) after 1m0s
[02:02:56.654] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:112:0)
[02:02:56.654] Timer tick, asking Buildbucket for the build status
[02:02:56.853] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:56.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:113:0) after 1m0s
[02:03:56.975] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:113:0)
[02:03:56.975] Timer tick, asking Buildbucket for the build status
[02:03:57.139] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:57.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:114:0) after 1m0s
[02:04:57.225] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:114:0)
[02:04:57.225] Timer tick, asking Buildbucket for the build status
[02:04:57.624] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:57.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:115:0) after 1m0s
[02:05:57.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:115:0)
[02:05:57.754] Timer tick, asking Buildbucket for the build status
[02:05:58.099] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:58.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:116:0) after 1m0s
[02:06:58.237] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:116:0)
[02:06:58.237] Timer tick, asking Buildbucket for the build status
[02:06:58.498] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:58.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:117:0) after 1m0s
[02:07:58.616] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:117:0)
[02:07:58.616] Timer tick, asking Buildbucket for the build status
[02:08:01.153] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:01.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:118:0) after 1m0s
[02:09:01.203] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:118:0)
[02:09:01.203] Timer tick, asking Buildbucket for the build status
[02:09:01.762] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:01.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:119:0) after 1m0s
[02:10:01.896] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:119:0)
[02:10:01.896] Timer tick, asking Buildbucket for the build status
[02:10:02.113] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:02.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:120:0) after 1m0s
[02:11:02.215] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:120:0)
[02:11:02.215] Timer tick, asking Buildbucket for the build status
[02:11:02.887] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:02.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:121:0) after 1m0s
[02:12:02.919] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:121:0)
[02:12:02.919] Timer tick, asking Buildbucket for the build status
[02:12:03.266] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:03.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:122:0) after 1m0s
[02:13:03.287] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:122:0)
[02:13:03.287] Timer tick, asking Buildbucket for the build status
[02:13:04.248] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:04.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:123:0) after 1m0s
[02:14:04.303] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:123:0)
[02:14:04.303] Timer tick, asking Buildbucket for the build status
[02:14:04.498] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:04.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:124:0) after 1m0s
[02:15:04.559] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:124:0)
[02:15:04.559] Timer tick, asking Buildbucket for the build status
[02:15:04.755] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:04.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:125:0) after 1m0s
[02:16:04.811] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:125:0)
[02:16:04.811] Timer tick, asking Buildbucket for the build status
[02:16:05.005] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:05.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:126:0) after 1m0s
[02:17:05.042] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:126:0)
[02:17:05.042] Timer tick, asking Buildbucket for the build status
[02:17:05.661] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:05.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:127:0) after 1m0s
[02:18:05.747] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:127:0)
[02:18:05.747] Timer tick, asking Buildbucket for the build status
[02:18:06.443] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:06.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:128:0) after 1m0s
[02:19:06.497] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:128:0)
[02:19:06.497] Timer tick, asking Buildbucket for the build status
[02:19:06.681] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:06.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:129:0) after 1m0s
[02:20:06.714] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:129:0)
[02:20:06.714] Timer tick, asking Buildbucket for the build status
[02:20:06.871] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:06.871] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:130:0) after 1m0s
[02:21:06.898] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:130:0)
[02:21:06.898] Timer tick, asking Buildbucket for the build status
[02:21:07.204] Build 8892420577593895376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:07.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9057850640327531568:131:0) after 1m0s
[02:22:00.607] Received PubSub notification, asking Buildbucket for the build status
[02:22:00.730] Build 8892420577593895376: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:22:00.730] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1577931719967627",
"created_by": "project:chromium",
"created_ts": "1577923906674567",
"failure_reason": "BUILD_FAILURE",
"id": "8892420577593895376",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"00cd5a46cac507988559c6672424fefe31f7caf4\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}, \"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\": \"build281-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 11765, \"got_angle_revision\": \"cbbfa2f28a0ee0ca652416d74b42c58238b24a3a\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"00cd5a46cac507988559c6672424fefe31f7caf4\", \"got_revision_cp\": \"refs/heads/master@{#727930}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"10a900e5ffaffdffe2806b1507af43a74acdfe9e\", \"got_v8_revision\": \"e7dd8e8dfc38217453b151faafe2088581b4542a\", \"got_v8_revision_cp\": \"refs/heads/8.1.81@{#1}\", \"got_webrtc_revision\": \"1c34ca7676e882100e29ef47258bfb2e41c30cbf\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30129}\", \"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\", \"revision\": \"00cd5a46cac507988559c6672424fefe31f7caf4\", \"swarm_hashes\": {\"0\": \"0d73742b4f87f451cc8bb18587845da9577b647c\", \"1\": \"6b01dd4056ee338dc2a112cae85a16640ba0081f\", \"10\": \"ebe85ee2664b92d81d40678320170f5868fb104d\", \"11\": \"69effaf4a319787f05a7742c4c11cc73da8d2121\", \"12\": \"cf5ec319d2a9e33b8e2f73fc41b42db93b217a35\", \"13\": \"b39335cb52c4f71a605f56ef324ab29d9f2d992e\", \"14\": \"ab00fb5cd620e6d2245d95db3f711bfc615e372c\", \"15\": \"e025c8780dc920ad5b5040740b823176db86ac7b\", \"16\": \"704e9ea97510ce96d1405e5efa6e9b7b93faac1e\", \"2\": \"98b10924ccfcda1b4cd6d88245e8fb09c63b7430\", \"3\": \"759175cc8535ee1a710c227d9bc304ceb177f581\", \"4\": \"23facfe8fe84f39b0b99bddbd42f8b843244e2d6\", \"5\": \"88d631f20bc833636c8db3798ab82084c923d3b9\", \"6\": \"9e5cfcfccf313cb49b16938b3a0ec48f73360f64\", \"7\": \"699b9a4c235dd29a878b2c6b2f1fff58ba865391\", \"8\": \"8af2545d25a581854447e2b86573e12a4ded2b2f\", \"9\": \"40ab5711e76b20ec9d7a81e0c0cd2c4196284bbc\"}}, \"ui\": {\"info\": \"Failed ios_web_inttests (iPhone 6s iOS 12.2).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1577923949722666",
"status": "COMPLETED",
"status_changed_ts": "1577923907280279",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/11765",
"builder:ToTiOS",
"buildset:commit/git/00cd5a46cac507988559c6672424fefe31f7caf4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/00cd5a46cac507988559c6672424fefe31f7caf4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057850640327531568",
"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/8892420577593895376/+/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:497c699c0f35d210",
"user_agent:luci-scheduler"
],
"updated_ts": "1577931720260225",
"url": "https://ci.chromium.org/b/8892420577593895376",
"utcnow_ts": "1577931720721823"
}
}
[02:22:00.730] Invocation finished in 2h10m16.047612689s with status FAILED