[08:46:20.222] New invocation is queued and will start shortly
[08:46:21.329] Starting the invocation (attempt 1)
[08:46:21.369] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:46:21.369] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:46:21.369] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054103789375116448",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b20f96817fbab10be2be26813bb93bf498198cfe\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9054103789375116448",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/b20f96817fbab10be2be26813bb93bf498198cfe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b20f96817fbab10be2be26813bb93bf498198cfe",
"gitiles_ref:refs/heads/master"
]
}
[08:46:22.176] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581497181518842",
"id": "8888673727350416608",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b20f96817fbab10be2be26813bb93bf498198cfe\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581497181927646",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/12249",
"builder:ToTiOS",
"buildset:commit/git/b20f96817fbab10be2be26813bb93bf498198cfe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b20f96817fbab10be2be26813bb93bf498198cfe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054103789375116448",
"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/8888673727350416608/+/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": "1581497181927768",
"url": "https://ci.chromium.org/b/8888673727350416608",
"utcnow_ts": "1581497182167587"
}
}
[08:46:22.176] Task URL: https://ci.chromium.org/b/8888673727350416608
[08:46:22.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:2:0) after 1m0s
[08:47:22.676] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:2:0)
[08:47:22.676] Timer tick, asking Buildbucket for the build status
[08:47:23.008] Build 8888673727350416608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:47:23.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:3:0) after 1m0s
[08:48:23.122] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:3:0)
[08:48:23.122] Timer tick, asking Buildbucket for the build status
[08:48:23.430] Build 8888673727350416608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:48:23.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:4:0) after 1m0s
[08:49:23.859] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:4:0)
[08:49:23.859] Timer tick, asking Buildbucket for the build status
[08:49:24.015] Build 8888673727350416608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:49:24.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:5:0) after 1m0s
[08:49:32.282] Received PubSub notification, asking Buildbucket for the build status
[08:49:32.705] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:24.136] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:5:0)
[08:50:24.136] Timer tick, asking Buildbucket for the build status
[08:50:24.508] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:24.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:7:0) after 1m0s
[08:51:28.833] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:7:0)
[08:51:28.833] Timer tick, asking Buildbucket for the build status
[08:51:29.375] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:29.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:8:0) after 1m0s
[08:52:29.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:8:0)
[08:52:29.731] Timer tick, asking Buildbucket for the build status
[08:52:29.869] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:29.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:9:0) after 1m0s
[08:53:30.004] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:9:0)
[08:53:30.004] Timer tick, asking Buildbucket for the build status
[08:53:30.215] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:30.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:10:0) after 1m0s
[08:54:30.382] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:10:0)
[08:54:30.382] Timer tick, asking Buildbucket for the build status
[08:54:30.549] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:30.549] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:11:0) after 1m0s
[08:55:30.572] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:11:0)
[08:55:30.572] Timer tick, asking Buildbucket for the build status
[08:55:31.266] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:31.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:12:0) after 1m0s
[08:56:31.325] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:12:0)
[08:56:31.325] Timer tick, asking Buildbucket for the build status
[08:56:31.738] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:31.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:13:0) after 1m0s
[08:57:31.832] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:13:0)
[08:57:31.832] Timer tick, asking Buildbucket for the build status
[08:57:32.300] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:32.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:14:0) after 1m0s
[08:58:32.361] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:14:0)
[08:58:32.361] Timer tick, asking Buildbucket for the build status
[08:58:35.093] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:35.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:15:0) after 1m0s
[08:59:35.255] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:15:0)
[08:59:35.255] Timer tick, asking Buildbucket for the build status
[08:59:35.421] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:35.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:16:0) after 1m0s
[09:00:35.440] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:16:0)
[09:00:35.440] Timer tick, asking Buildbucket for the build status
[09:00:35.734] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:35.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:17:0) after 1m0s
[09:01:35.794] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:17:0)
[09:01:35.794] Timer tick, asking Buildbucket for the build status
[09:01:35.958] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:35.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:18:0) after 1m0s
[09:02:36.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:18:0)
[09:02:36.087] Timer tick, asking Buildbucket for the build status
[09:02:36.273] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:36.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:19:0) after 1m0s
[09:03:36.292] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:19:0)
[09:03:36.292] Timer tick, asking Buildbucket for the build status
[09:03:36.718] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:36.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:20:0) after 1m0s
[09:04:36.762] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:20:0)
[09:04:36.762] Timer tick, asking Buildbucket for the build status
[09:04:37.074] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:37.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:21:0) after 1m0s
[09:05:37.197] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:21:0)
[09:05:37.197] Timer tick, asking Buildbucket for the build status
[09:05:37.872] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:37.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:22:0) after 1m0s
[09:06:37.955] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:22:0)
[09:06:37.955] Timer tick, asking Buildbucket for the build status
[09:06:38.096] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:38.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:23:0) after 1m0s
[09:07:38.194] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:23:0)
[09:07:38.194] Timer tick, asking Buildbucket for the build status
[09:07:38.359] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:38.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:24:0) after 1m0s
[09:08:38.477] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:24:0)
[09:08:38.477] Timer tick, asking Buildbucket for the build status
[09:08:38.645] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:38.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:25:0) after 1m0s
[09:09:38.755] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:25:0)
[09:09:38.755] Timer tick, asking Buildbucket for the build status
[09:09:38.967] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:38.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:26:0) after 1m0s
[09:10:39.017] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:26:0)
[09:10:39.017] Timer tick, asking Buildbucket for the build status
[09:10:39.286] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:39.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:27:0) after 1m0s
[09:11:39.282] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:27:0)
[09:11:39.282] Timer tick, asking Buildbucket for the build status
[09:11:39.601] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:39.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:28:0) after 1m0s
[09:12:39.678] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:28:0)
[09:12:39.678] Timer tick, asking Buildbucket for the build status
[09:12:40.564] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:40.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:29:0) after 1m0s
[09:13:40.584] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:29:0)
[09:13:40.584] Timer tick, asking Buildbucket for the build status
[09:13:40.720] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:40.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:30:0) after 1m0s
[09:14:40.834] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:30:0)
[09:14:40.834] Timer tick, asking Buildbucket for the build status
[09:14:41.218] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:41.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:31:0) after 1m0s
[09:15:41.351] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:31:0)
[09:15:41.351] Timer tick, asking Buildbucket for the build status
[09:15:41.844] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:41.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:32:0) after 1m0s
[09:16:41.942] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:32:0)
[09:16:41.942] Timer tick, asking Buildbucket for the build status
[09:16:42.182] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:42.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:33:0) after 1m0s
[09:17:42.244] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:33:0)
[09:17:42.244] Timer tick, asking Buildbucket for the build status
[09:17:43.053] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:43.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:34:0) after 1m0s
[09:18:43.079] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:34:0)
[09:18:43.079] Timer tick, asking Buildbucket for the build status
[09:18:43.204] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:43.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:35:0) after 1m0s
[09:19:43.294] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:35:0)
[09:19:43.294] Timer tick, asking Buildbucket for the build status
[09:19:43.440] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:43.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:36:0) after 1m0s
[09:20:43.478] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:36:0)
[09:20:43.478] Timer tick, asking Buildbucket for the build status
[09:20:44.422] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:44.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:37:0) after 1m0s
[09:21:44.477] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:37:0)
[09:21:44.477] Timer tick, asking Buildbucket for the build status
[09:21:44.614] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:44.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:38:0) after 1m0s
[09:22:44.592] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:38:0)
[09:22:44.592] Timer tick, asking Buildbucket for the build status
[09:22:44.747] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:44.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:39:0) after 1m0s
[09:23:44.938] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:39:0)
[09:23:44.938] Timer tick, asking Buildbucket for the build status
[09:23:45.117] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:45.117] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:40:0) after 1m0s
[09:24:45.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:40:0)
[09:24:45.087] Timer tick, asking Buildbucket for the build status
[09:24:45.243] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:45.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:41:0) after 1m0s
[09:25:45.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:41:0)
[09:25:45.275] Timer tick, asking Buildbucket for the build status
[09:25:45.517] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:45.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:42:0) after 1m0s
[09:26:45.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:42:0)
[09:26:45.574] Timer tick, asking Buildbucket for the build status
[09:26:46.166] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:46.166] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:43:0) after 1m0s
[09:27:46.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:43:0)
[09:27:46.248] Timer tick, asking Buildbucket for the build status
[09:27:46.925] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:46.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:44:0) after 1m0s
[09:28:46.987] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:44:0)
[09:28:46.988] Timer tick, asking Buildbucket for the build status
[09:28:47.150] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:47.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:45:0) after 1m0s
[09:29:47.145] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:45:0)
[09:29:47.145] Timer tick, asking Buildbucket for the build status
[09:29:47.375] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:47.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:46:0) after 1m0s
[09:30:47.465] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:46:0)
[09:30:47.465] Timer tick, asking Buildbucket for the build status
[09:30:47.647] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:47.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:47:0) after 1m0s
[09:31:47.734] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:47:0)
[09:31:47.734] Timer tick, asking Buildbucket for the build status
[09:31:47.874] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:47.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:48:0) after 1m0s
[09:32:47.982] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:48:0)
[09:32:47.982] Timer tick, asking Buildbucket for the build status
[09:32:48.161] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:48.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:49:0) after 1m0s
[09:33:48.292] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:49:0)
[09:33:48.292] Timer tick, asking Buildbucket for the build status
[09:33:49.071] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:49.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:50:0) after 1m0s
[09:34:49.196] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:50:0)
[09:34:49.196] Timer tick, asking Buildbucket for the build status
[09:34:49.403] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:49.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:51:0) after 1m0s
[09:35:49.553] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:51:0)
[09:35:49.553] Timer tick, asking Buildbucket for the build status
[09:35:49.694] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:49.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:52:0) after 1m0s
[09:36:49.715] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:52:0)
[09:36:49.715] Timer tick, asking Buildbucket for the build status
[09:36:49.859] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:49.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:53:0) after 1m0s
[09:37:49.881] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:53:0)
[09:37:49.881] Timer tick, asking Buildbucket for the build status
[09:37:50.635] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:50.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:54:0) after 1m0s
[09:38:50.743] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:54:0)
[09:38:50.743] Timer tick, asking Buildbucket for the build status
[09:38:50.920] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:50.920] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:55:0) after 1m0s
[09:39:51.083] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:55:0)
[09:39:51.083] Timer tick, asking Buildbucket for the build status
[09:39:51.903] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:51.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:56:0) after 1m0s
[09:40:51.976] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:56:0)
[09:40:51.976] Timer tick, asking Buildbucket for the build status
[09:40:52.602] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:52.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:57:0) after 1m0s
[09:41:52.643] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:57:0)
[09:41:52.643] Timer tick, asking Buildbucket for the build status
[09:41:53.016] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:53.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:58:0) after 1m0s
[09:42:53.233] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:58:0)
[09:42:53.233] Timer tick, asking Buildbucket for the build status
[09:42:53.452] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:53.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:59:0) after 1m0s
[09:43:53.526] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:59:0)
[09:43:53.526] Timer tick, asking Buildbucket for the build status
[09:43:53.733] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:53.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:60:0) after 1m0s
[09:44:53.766] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:60:0)
[09:44:53.766] Timer tick, asking Buildbucket for the build status
[09:44:53.915] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:53.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:61:0) after 1m0s
[09:45:53.943] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:61:0)
[09:45:53.943] Timer tick, asking Buildbucket for the build status
[09:45:54.579] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:54.579] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:62:0) after 1m0s
[09:46:54.635] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:62:0)
[09:46:54.635] Timer tick, asking Buildbucket for the build status
[09:46:54.756] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:54.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:63:0) after 1m0s
[09:47:54.823] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:63:0)
[09:47:54.823] Timer tick, asking Buildbucket for the build status
[09:47:55.344] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:55.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:64:0) after 1m0s
[09:48:55.385] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:64:0)
[09:48:55.385] Timer tick, asking Buildbucket for the build status
[09:48:55.762] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:55.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:65:0) after 1m0s
[09:49:55.853] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:65:0)
[09:49:55.853] Timer tick, asking Buildbucket for the build status
[09:49:55.993] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:55.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:66:0) after 1m0s
[09:50:56.081] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:66:0)
[09:50:56.081] Timer tick, asking Buildbucket for the build status
[09:50:56.567] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:56.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:67:0) after 1m0s
[09:51:56.589] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:67:0)
[09:51:56.589] Timer tick, asking Buildbucket for the build status
[09:51:56.856] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:56.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:68:0) after 1m0s
[09:52:56.933] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:68:0)
[09:52:56.933] Timer tick, asking Buildbucket for the build status
[09:52:57.091] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:57.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:69:0) after 1m0s
[09:53:57.075] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:69:0)
[09:53:57.075] Timer tick, asking Buildbucket for the build status
[09:53:57.349] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:57.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:70:0) after 1m0s
[09:54:57.374] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:70:0)
[09:54:57.374] Timer tick, asking Buildbucket for the build status
[09:54:57.575] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:57.575] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:71:0) after 1m0s
[09:55:57.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:71:0)
[09:55:57.686] Timer tick, asking Buildbucket for the build status
[09:55:57.984] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:57.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:72:0) after 1m0s
[09:56:58.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:72:0)
[09:56:58.131] Timer tick, asking Buildbucket for the build status
[09:56:58.276] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:58.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:73:0) after 1m0s
[09:57:58.373] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:73:0)
[09:57:58.373] Timer tick, asking Buildbucket for the build status
[09:57:58.919] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:58.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:74:0) after 1m0s
[09:58:58.941] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:74:0)
[09:58:58.941] Timer tick, asking Buildbucket for the build status
[09:58:59.327] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:59.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:75:0) after 1m0s
[09:59:59.351] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:75:0)
[09:59:59.351] Timer tick, asking Buildbucket for the build status
[09:59:59.502] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:59.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:76:0) after 1m0s
[10:00:59.553] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:76:0)
[10:00:59.553] Timer tick, asking Buildbucket for the build status
[10:01:00.257] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:00.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:77:0) after 1m0s
[10:02:00.278] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:77:0)
[10:02:00.278] Timer tick, asking Buildbucket for the build status
[10:02:00.650] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:00.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:78:0) after 1m0s
[10:03:00.727] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:78:0)
[10:03:00.727] Timer tick, asking Buildbucket for the build status
[10:03:00.906] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:00.906] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:79:0) after 1m0s
[10:04:00.932] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:79:0)
[10:04:00.932] Timer tick, asking Buildbucket for the build status
[10:04:01.419] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:01.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:80:0) after 1m0s
[10:05:01.441] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:80:0)
[10:05:01.441] Timer tick, asking Buildbucket for the build status
[10:05:02.381] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:02.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:81:0) after 1m0s
[10:06:02.477] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:81:0)
[10:06:02.477] Timer tick, asking Buildbucket for the build status
[10:06:02.945] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:02.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:82:0) after 1m0s
[10:07:02.966] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:82:0)
[10:07:02.966] Timer tick, asking Buildbucket for the build status
[10:07:03.142] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:03.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:83:0) after 1m0s
[10:08:03.216] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:83:0)
[10:08:03.216] Timer tick, asking Buildbucket for the build status
[10:08:03.382] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:03.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:84:0) after 1m0s
[10:09:03.403] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:84:0)
[10:09:03.403] Timer tick, asking Buildbucket for the build status
[10:09:03.538] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:03.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:85:0) after 1m0s
[10:10:03.647] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:85:0)
[10:10:03.647] Timer tick, asking Buildbucket for the build status
[10:10:03.898] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:03.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:86:0) after 1m0s
[10:11:04.019] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:86:0)
[10:11:04.019] Timer tick, asking Buildbucket for the build status
[10:11:04.456] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:04.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:87:0) after 1m0s
[10:12:04.592] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:87:0)
[10:12:04.592] Timer tick, asking Buildbucket for the build status
[10:12:04.801] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:04.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:88:0) after 1m0s
[10:13:04.811] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:88:0)
[10:13:04.811] Timer tick, asking Buildbucket for the build status
[10:13:04.964] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:04.964] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:89:0) after 1m0s
[10:14:05.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:89:0)
[10:14:05.131] Timer tick, asking Buildbucket for the build status
[10:14:05.491] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:05.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:90:0) after 1m0s
[10:15:05.579] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:90:0)
[10:15:05.579] Timer tick, asking Buildbucket for the build status
[10:15:05.792] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:05.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:91:0) after 1m0s
[10:16:05.809] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:91:0)
[10:16:05.809] Timer tick, asking Buildbucket for the build status
[10:16:06.901] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:06.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:92:0) after 1m0s
[10:17:06.923] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:92:0)
[10:17:06.923] Timer tick, asking Buildbucket for the build status
[10:17:07.147] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:07.147] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:93:0) after 1m0s
[10:18:07.273] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:93:0)
[10:18:07.273] Timer tick, asking Buildbucket for the build status
[10:18:07.419] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:07.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:94:0) after 1m0s
[10:19:07.442] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:94:0)
[10:19:07.442] Timer tick, asking Buildbucket for the build status
[10:19:07.911] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:07.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:95:0) after 1m0s
[10:20:07.927] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:95:0)
[10:20:07.927] Timer tick, asking Buildbucket for the build status
[10:20:08.064] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:08.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:96:0) after 1m0s
[10:21:08.215] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:96:0)
[10:21:08.215] Timer tick, asking Buildbucket for the build status
[10:21:09.255] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:09.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:97:0) after 1m0s
[10:22:09.404] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:97:0)
[10:22:09.404] Timer tick, asking Buildbucket for the build status
[10:22:09.561] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:09.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:98:0) after 1m0s
[10:23:09.561] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:98:0)
[10:23:09.561] Timer tick, asking Buildbucket for the build status
[10:23:09.678] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:09.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:99:0) after 1m0s
[10:24:09.715] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:99:0)
[10:24:09.715] Timer tick, asking Buildbucket for the build status
[10:24:09.881] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:09.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:100:0) after 1m0s
[10:25:10.008] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:100:0)
[10:25:10.008] Timer tick, asking Buildbucket for the build status
[10:25:10.195] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:10.195] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:101:0) after 1m0s
[10:26:10.323] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:101:0)
[10:26:10.323] Timer tick, asking Buildbucket for the build status
[10:26:15.013] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:15.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:102:0) after 1m0s
[10:27:15.098] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:102:0)
[10:27:15.098] Timer tick, asking Buildbucket for the build status
[10:27:15.441] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:15.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:103:0) after 1m0s
[10:28:15.442] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:103:0)
[10:28:15.442] Timer tick, asking Buildbucket for the build status
[10:28:15.809] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:15.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:104:0) after 1m0s
[10:29:15.966] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:104:0)
[10:29:15.966] Timer tick, asking Buildbucket for the build status
[10:29:16.154] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:16.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:105:0) after 1m0s
[10:30:16.310] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:105:0)
[10:30:16.310] Timer tick, asking Buildbucket for the build status
[10:30:16.460] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:16.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:106:0) after 1m0s
[10:31:16.592] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:106:0)
[10:31:16.592] Timer tick, asking Buildbucket for the build status
[10:31:17.318] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:17.318] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:107:0) after 1m0s
[10:32:17.314] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:107:0)
[10:32:17.315] Timer tick, asking Buildbucket for the build status
[10:32:17.452] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:17.452] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:108:0) after 1m0s
[10:33:17.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:108:0)
[10:33:17.578] Timer tick, asking Buildbucket for the build status
[10:33:17.724] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:17.724] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:109:0) after 1m0s
[10:34:17.851] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:109:0)
[10:34:17.851] Timer tick, asking Buildbucket for the build status
[10:34:17.993] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:17.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:110:0) after 1m0s
[10:35:18.051] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:110:0)
[10:35:18.051] Timer tick, asking Buildbucket for the build status
[10:35:18.221] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:18.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:111:0) after 1m0s
[10:36:18.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:111:0)
[10:36:18.249] Timer tick, asking Buildbucket for the build status
[10:36:18.414] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:18.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:112:0) after 1m0s
[10:37:18.472] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:112:0)
[10:37:18.472] Timer tick, asking Buildbucket for the build status
[10:37:18.604] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:18.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:113:0) after 1m0s
[10:38:18.629] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:113:0)
[10:38:18.629] Timer tick, asking Buildbucket for the build status
[10:38:18.844] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:18.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:114:0) after 1m0s
[10:39:18.867] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:114:0)
[10:39:18.867] Timer tick, asking Buildbucket for the build status
[10:39:18.992] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:18.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:115:0) after 1m0s
[10:40:19.022] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:115:0)
[10:40:19.022] Timer tick, asking Buildbucket for the build status
[10:40:19.826] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:19.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:116:0) after 1m0s
[10:41:19.929] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:116:0)
[10:41:19.929] Timer tick, asking Buildbucket for the build status
[10:41:20.102] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:20.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:117:0) after 1m0s
[10:42:20.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:117:0)
[10:42:20.133] Timer tick, asking Buildbucket for the build status
[10:42:22.371] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:22.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:118:0) after 1m0s
[10:43:22.577] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:118:0)
[10:43:22.577] Timer tick, asking Buildbucket for the build status
[10:43:22.856] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:22.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:119:0) after 1m0s
[10:44:22.872] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:119:0)
[10:44:22.872] Timer tick, asking Buildbucket for the build status
[10:44:23.031] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:23.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:120:0) after 1m0s
[10:45:23.100] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:120:0)
[10:45:23.100] Timer tick, asking Buildbucket for the build status
[10:45:23.612] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:23.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:121:0) after 1m0s
[10:46:23.724] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:121:0)
[10:46:23.724] Timer tick, asking Buildbucket for the build status
[10:46:24.580] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:24.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:122:0) after 1m0s
[10:47:24.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:122:0)
[10:47:24.686] Timer tick, asking Buildbucket for the build status
[10:47:25.238] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:25.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:123:0) after 1m0s
[10:48:25.344] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:123:0)
[10:48:25.344] Timer tick, asking Buildbucket for the build status
[10:48:25.916] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:25.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:124:0) after 1m0s
[10:49:26.009] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:124:0)
[10:49:26.009] Timer tick, asking Buildbucket for the build status
[10:49:26.165] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:26.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:125:0) after 1m0s
[10:50:26.225] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:125:0)
[10:50:26.225] Timer tick, asking Buildbucket for the build status
[10:50:26.642] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:26.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:126:0) after 1m0s
[10:51:26.775] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:126:0)
[10:51:26.775] Timer tick, asking Buildbucket for the build status
[10:51:26.960] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:26.960] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:127:0) after 1m0s
[10:52:27.086] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:127:0)
[10:52:27.086] Timer tick, asking Buildbucket for the build status
[10:52:27.221] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:27.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:128:0) after 1m0s
[10:53:27.244] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:128:0)
[10:53:27.244] Timer tick, asking Buildbucket for the build status
[10:53:27.434] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:27.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:129:0) after 1m0s
[10:54:27.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:129:0)
[10:54:27.555] Timer tick, asking Buildbucket for the build status
[10:54:28.013] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:28.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:130:0) after 1m0s
[10:55:28.033] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:130:0)
[10:55:28.033] Timer tick, asking Buildbucket for the build status
[10:55:28.224] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:28.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:131:0) after 1m0s
[10:56:28.217] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:131:0)
[10:56:28.217] Timer tick, asking Buildbucket for the build status
[10:56:28.377] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:28.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:132:0) after 1m0s
[10:57:28.470] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:132:0)
[10:57:28.470] Timer tick, asking Buildbucket for the build status
[10:57:29.295] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:29.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:133:0) after 1m0s
[10:58:29.393] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:133:0)
[10:58:29.393] Timer tick, asking Buildbucket for the build status
[10:58:29.564] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:29.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:134:0) after 1m0s
[10:59:29.640] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:134:0)
[10:59:29.640] Timer tick, asking Buildbucket for the build status
[10:59:30.334] Build 8888673727350416608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:30.334] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9054103789375116448:135:0) after 1m0s
[11:00:21.895] Received PubSub notification, asking Buildbucket for the build status
[11:00:22.184] Build 8888673727350416608: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:00:22.184] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581505220413687",
"created_by": "project:chromium",
"created_ts": "1581497181518842",
"failure_reason": "BUILD_FAILURE",
"id": "8888673727350416608",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b20f96817fbab10be2be26813bb93bf498198cfe\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('compile') (retcode: 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\": \"build286-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 12249, \"got_angle_revision\": \"e1ccac7ff9f088c841a4393b633be402012cfb92\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"b20f96817fbab10be2be26813bb93bf498198cfe\", \"got_revision_cp\": \"refs/heads/master@{#740589}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"6cbb02e0dc934ac1e21b182f0f632b4e806449a6\", \"got_v8_revision\": \"56ab990e69987df228757938e23a9bafccab2fe5\", \"got_v8_revision_cp\": \"refs/heads/8.2.57@{#1}\", \"got_webrtc_revision\": \"d4c3c3a454215b21f02d2a772a729b4c87d6b33e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30486}\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"ios/unified_builder_tester\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b20f96817fbab10be2be26813bb93bf498198cfe\"}, \"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_11a1027\"], \"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\": [\"build286-m9\"], \"mac_model\": [\"MacPro6,1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Mac\", \"Mac-10.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4812-ea7e8fc\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Step('compile') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581497370201188",
"status": "COMPLETED",
"status_changed_ts": "1581497371764229",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/12249",
"builder:ToTiOS",
"buildset:commit/git/b20f96817fbab10be2be26813bb93bf498198cfe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b20f96817fbab10be2be26813bb93bf498198cfe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054103789375116448",
"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/8888673727350416608/+/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:4a51657369154910",
"user_agent:luci-scheduler"
],
"updated_ts": "1581505220541412",
"url": "https://ci.chromium.org/b/8888673727350416608",
"utcnow_ts": "1581505222174363"
}
}
[11:00:22.184] Invocation finished in 2h14m1.979559724s with status FAILED