[19:17:58.251] New invocation is queued and will start shortly
[19:17:59.350] Starting the invocation (attempt 1)
[19:17:59.408] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:17:59.408] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:17:59.408] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9055604198846450752",
"parameters_json": "{\"builder_name\":\"ToTiOS\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e4151601c15f976722bed73a8b2783e0962df72e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOS",
"scheduler_invocation_id:9055604198846450752",
"scheduler_job_id:chromium/ToTiOS",
"user_agent:luci-scheduler",
"buildset:commit/git/e4151601c15f976722bed73a8b2783e0962df72e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4151601c15f976722bed73a8b2783e0962df72e",
"gitiles_ref:refs/heads/master"
]
}
[19:18:00.366] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1580066279614521",
"id": "8890174136745774736",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4151601c15f976722bed73a8b2783e0962df72e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580066280016049",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/12044",
"builder:ToTiOS",
"buildset:commit/git/e4151601c15f976722bed73a8b2783e0962df72e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4151601c15f976722bed73a8b2783e0962df72e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055604198846450752",
"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/8890174136745774736/+/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": "1580066280016154",
"url": "https://ci.chromium.org/b/8890174136745774736",
"utcnow_ts": "1580066280357943"
}
}
[19:18:00.366] Task URL: https://ci.chromium.org/b/8890174136745774736
[19:18:00.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:2:0) after 1m0s
[19:19:00.564] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:2:0)
[19:19:00.564] Timer tick, asking Buildbucket for the build status
[19:19:00.801] Build 8890174136745774736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:19:00.801] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:3:0) after 1m0s
[19:20:00.914] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:3:0)
[19:20:00.914] Timer tick, asking Buildbucket for the build status
[19:20:01.205] Build 8890174136745774736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:20:01.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:4:0) after 1m0s
[19:21:00.289] Received PubSub notification, asking Buildbucket for the build status
[19:21:00.787] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:01.304] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:4:0)
[19:21:01.304] Timer tick, asking Buildbucket for the build status
[19:21:01.476] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:01.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:6:0) after 1m0s
[19:22:01.717] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:6:0)
[19:22:01.717] Timer tick, asking Buildbucket for the build status
[19:22:02.052] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:02.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:7:0) after 1m0s
[19:23:02.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:7:0)
[19:23:02.135] Timer tick, asking Buildbucket for the build status
[19:23:02.635] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:02.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:8:0) after 1m0s
[19:24:02.683] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:8:0)
[19:24:02.683] Timer tick, asking Buildbucket for the build status
[19:24:03.612] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:03.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:9:0) after 1m0s
[19:25:03.732] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:9:0)
[19:25:03.732] Timer tick, asking Buildbucket for the build status
[19:25:04.074] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:04.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:10:0) after 1m0s
[19:26:04.131] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:10:0)
[19:26:04.131] Timer tick, asking Buildbucket for the build status
[19:26:04.666] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:04.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:11:0) after 1m0s
[19:27:04.741] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:11:0)
[19:27:04.741] Timer tick, asking Buildbucket for the build status
[19:27:04.881] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:04.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:12:0) after 1m0s
[19:28:04.973] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:12:0)
[19:28:04.973] Timer tick, asking Buildbucket for the build status
[19:28:05.601] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:05.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:13:0) after 1m0s
[19:29:05.619] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:13:0)
[19:29:05.619] Timer tick, asking Buildbucket for the build status
[19:29:06.825] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:06.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:14:0) after 1m0s
[19:30:07.030] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:14:0)
[19:30:07.030] Timer tick, asking Buildbucket for the build status
[19:30:07.344] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:07.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:15:0) after 1m0s
[19:31:07.526] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:15:0)
[19:31:07.526] Timer tick, asking Buildbucket for the build status
[19:31:07.657] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:07.658] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:16:0) after 1m0s
[19:32:07.935] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:16:0)
[19:32:07.935] Timer tick, asking Buildbucket for the build status
[19:32:09.403] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:09.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:17:0) after 1m0s
[19:33:09.629] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:17:0)
[19:33:09.629] Timer tick, asking Buildbucket for the build status
[19:33:09.782] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:09.782] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:18:0) after 1m0s
[19:34:09.813] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:18:0)
[19:34:09.813] Timer tick, asking Buildbucket for the build status
[19:34:09.963] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:09.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:19:0) after 1m0s
[19:35:09.980] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:19:0)
[19:35:09.980] Timer tick, asking Buildbucket for the build status
[19:35:10.139] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:10.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:20:0) after 1m0s
[19:36:10.240] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:20:0)
[19:36:10.240] Timer tick, asking Buildbucket for the build status
[19:36:10.670] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:10.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:21:0) after 1m0s
[19:37:10.692] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:21:0)
[19:37:10.692] Timer tick, asking Buildbucket for the build status
[19:37:10.840] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:10.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:22:0) after 1m0s
[19:38:10.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:22:0)
[19:38:10.996] Timer tick, asking Buildbucket for the build status
[19:38:11.229] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:11.229] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:23:0) after 1m0s
[19:39:11.301] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:23:0)
[19:39:11.301] Timer tick, asking Buildbucket for the build status
[19:39:11.430] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:11.430] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:24:0) after 1m0s
[19:40:11.452] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:24:0)
[19:40:11.452] Timer tick, asking Buildbucket for the build status
[19:40:11.600] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:11.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:25:0) after 1m0s
[19:41:11.675] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:25:0)
[19:41:11.675] Timer tick, asking Buildbucket for the build status
[19:41:11.922] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:11.922] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:26:0) after 1m0s
[19:42:12.071] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:26:0)
[19:42:12.071] Timer tick, asking Buildbucket for the build status
[19:42:12.253] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:12.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:27:0) after 1m0s
[19:43:12.327] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:27:0)
[19:43:12.327] Timer tick, asking Buildbucket for the build status
[19:43:12.480] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:12.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:28:0) after 1m0s
[19:44:12.605] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:28:0)
[19:44:12.605] Timer tick, asking Buildbucket for the build status
[19:44:14.070] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:14.070] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:29:0) after 1m0s
[19:45:14.223] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:29:0)
[19:45:14.223] Timer tick, asking Buildbucket for the build status
[19:45:14.710] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:14.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:30:0) after 1m0s
[19:46:14.731] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:30:0)
[19:46:14.731] Timer tick, asking Buildbucket for the build status
[19:46:15.349] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:15.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:31:0) after 1m0s
[19:47:15.448] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:31:0)
[19:47:15.448] Timer tick, asking Buildbucket for the build status
[19:47:15.669] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:15.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:32:0) after 1m0s
[19:48:15.810] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:32:0)
[19:48:15.810] Timer tick, asking Buildbucket for the build status
[19:48:16.223] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:16.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:33:0) after 1m0s
[19:49:16.204] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:33:0)
[19:49:16.204] Timer tick, asking Buildbucket for the build status
[19:49:16.411] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:16.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:34:0) after 1m0s
[19:50:16.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:34:0)
[19:50:16.563] Timer tick, asking Buildbucket for the build status
[19:50:16.725] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:16.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:35:0) after 1m0s
[19:51:16.744] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:35:0)
[19:51:16.744] Timer tick, asking Buildbucket for the build status
[19:51:16.985] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:16.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:36:0) after 1m0s
[19:52:17.062] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:36:0)
[19:52:17.062] Timer tick, asking Buildbucket for the build status
[19:52:17.379] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:17.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:37:0) after 1m0s
[19:53:17.436] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:37:0)
[19:53:17.436] Timer tick, asking Buildbucket for the build status
[19:53:17.970] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:17.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:38:0) after 1m0s
[19:54:18.001] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:38:0)
[19:54:18.001] Timer tick, asking Buildbucket for the build status
[19:54:18.179] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:18.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:39:0) after 1m0s
[19:55:18.357] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:39:0)
[19:55:18.357] Timer tick, asking Buildbucket for the build status
[19:55:18.815] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:18.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:40:0) after 1m0s
[19:56:18.884] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:40:0)
[19:56:18.884] Timer tick, asking Buildbucket for the build status
[19:56:19.212] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:19.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:41:0) after 1m0s
[19:57:19.388] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:41:0)
[19:57:19.388] Timer tick, asking Buildbucket for the build status
[19:57:20.122] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:20.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:42:0) after 1m0s
[19:58:20.248] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:42:0)
[19:58:20.248] Timer tick, asking Buildbucket for the build status
[19:58:20.594] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:20.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:43:0) after 1m0s
[19:59:20.658] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:43:0)
[19:59:20.658] Timer tick, asking Buildbucket for the build status
[19:59:20.947] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:20.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:44:0) after 1m0s
[20:00:21.097] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:44:0)
[20:00:21.097] Timer tick, asking Buildbucket for the build status
[20:00:21.233] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:21.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:45:0) after 1m0s
[20:01:21.292] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:45:0)
[20:01:21.292] Timer tick, asking Buildbucket for the build status
[20:01:21.432] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:21.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:46:0) after 1m0s
[20:02:21.663] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:46:0)
[20:02:21.663] Timer tick, asking Buildbucket for the build status
[20:02:22.775] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:22.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:47:0) after 1m0s
[20:03:22.956] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:47:0)
[20:03:22.956] Timer tick, asking Buildbucket for the build status
[20:03:23.539] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:23.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:48:0) after 1m0s
[20:04:23.627] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:48:0)
[20:04:23.627] Timer tick, asking Buildbucket for the build status
[20:04:23.855] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:23.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:49:0) after 1m0s
[20:05:23.906] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:49:0)
[20:05:23.906] Timer tick, asking Buildbucket for the build status
[20:05:24.160] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:24.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:50:0) after 1m0s
[20:06:24.202] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:50:0)
[20:06:24.202] Timer tick, asking Buildbucket for the build status
[20:06:24.856] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:24.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:51:0) after 1m0s
[20:07:24.828] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:51:0)
[20:07:24.828] Timer tick, asking Buildbucket for the build status
[20:07:25.311] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:25.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:52:0) after 1m0s
[20:08:25.375] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:52:0)
[20:08:25.375] Timer tick, asking Buildbucket for the build status
[20:08:25.521] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:25.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:53:0) after 1m0s
[20:09:25.595] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:53:0)
[20:09:25.595] Timer tick, asking Buildbucket for the build status
[20:09:26.143] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:26.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:54:0) after 1m0s
[20:10:26.217] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:54:0)
[20:10:26.217] Timer tick, asking Buildbucket for the build status
[20:10:26.858] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:26.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:55:0) after 1m0s
[20:11:26.961] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:55:0)
[20:11:26.961] Timer tick, asking Buildbucket for the build status
[20:11:27.122] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:27.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:56:0) after 1m0s
[20:12:27.190] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:56:0)
[20:12:27.190] Timer tick, asking Buildbucket for the build status
[20:12:27.386] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:27.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:57:0) after 1m0s
[20:13:27.356] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:57:0)
[20:13:27.356] Timer tick, asking Buildbucket for the build status
[20:13:27.638] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:27.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:58:0) after 1m0s
[20:14:27.736] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:58:0)
[20:14:27.736] Timer tick, asking Buildbucket for the build status
[20:14:28.251] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:28.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:59:0) after 1m0s
[20:15:28.300] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:59:0)
[20:15:28.300] Timer tick, asking Buildbucket for the build status
[20:15:29.603] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:29.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:60:0) after 1m0s
[20:16:29.635] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:60:0)
[20:16:29.635] Timer tick, asking Buildbucket for the build status
[20:16:29.814] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:29.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:61:0) after 1m0s
[20:17:29.829] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:61:0)
[20:17:29.829] Timer tick, asking Buildbucket for the build status
[20:17:30.573] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:30.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:62:0) after 1m0s
[20:18:30.618] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:62:0)
[20:18:30.618] Timer tick, asking Buildbucket for the build status
[20:18:30.778] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:30.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:63:0) after 1m0s
[20:19:30.797] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:63:0)
[20:19:30.797] Timer tick, asking Buildbucket for the build status
[20:19:32.183] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:32.183] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:64:0) after 1m0s
[20:20:32.341] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:64:0)
[20:20:32.341] Timer tick, asking Buildbucket for the build status
[20:20:32.581] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:32.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:65:0) after 1m0s
[20:21:32.662] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:65:0)
[20:21:32.662] Timer tick, asking Buildbucket for the build status
[20:21:32.802] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:32.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:66:0) after 1m0s
[20:22:32.866] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:66:0)
[20:22:32.866] Timer tick, asking Buildbucket for the build status
[20:22:33.078] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:33.078] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:67:0) after 1m0s
[20:23:33.139] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:67:0)
[20:23:33.139] Timer tick, asking Buildbucket for the build status
[20:23:33.316] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:33.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:68:0) after 1m0s
[20:24:33.424] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:68:0)
[20:24:33.424] Timer tick, asking Buildbucket for the build status
[20:24:33.591] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:33.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:69:0) after 1m0s
[20:25:33.641] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:69:0)
[20:25:33.641] Timer tick, asking Buildbucket for the build status
[20:25:33.904] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:33.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:70:0) after 1m0s
[20:26:33.929] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:70:0)
[20:26:33.929] Timer tick, asking Buildbucket for the build status
[20:26:34.116] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:34.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:71:0) after 1m0s
[20:27:34.144] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:71:0)
[20:27:34.144] Timer tick, asking Buildbucket for the build status
[20:27:34.294] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:34.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:72:0) after 1m0s
[20:28:34.333] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:72:0)
[20:28:34.334] Timer tick, asking Buildbucket for the build status
[20:28:34.501] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:34.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:73:0) after 1m0s
[20:29:34.553] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:73:0)
[20:29:34.553] Timer tick, asking Buildbucket for the build status
[20:29:34.887] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:34.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:74:0) after 1m0s
[20:30:34.905] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:74:0)
[20:30:34.905] Timer tick, asking Buildbucket for the build status
[20:30:35.480] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:35.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:75:0) after 1m0s
[20:31:35.548] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:75:0)
[20:31:35.548] Timer tick, asking Buildbucket for the build status
[20:31:35.816] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:35.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:76:0) after 1m0s
[20:32:35.904] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:76:0)
[20:32:35.904] Timer tick, asking Buildbucket for the build status
[20:32:36.138] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:36.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:77:0) after 1m0s
[20:33:36.169] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:77:0)
[20:33:36.169] Timer tick, asking Buildbucket for the build status
[20:33:36.496] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:36.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:78:0) after 1m0s
[20:34:36.531] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:78:0)
[20:34:36.531] Timer tick, asking Buildbucket for the build status
[20:34:36.836] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:36.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:79:0) after 1m0s
[20:35:36.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:79:0)
[20:35:36.856] Timer tick, asking Buildbucket for the build status
[20:35:37.039] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:37.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:80:0) after 1m0s
[20:36:37.080] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:80:0)
[20:36:37.080] Timer tick, asking Buildbucket for the build status
[20:36:37.220] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:37.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:81:0) after 1m0s
[20:37:37.252] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:81:0)
[20:37:37.252] Timer tick, asking Buildbucket for the build status
[20:37:37.530] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:37.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:82:0) after 1m0s
[20:38:37.563] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:82:0)
[20:38:37.563] Timer tick, asking Buildbucket for the build status
[20:38:37.734] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:37.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:83:0) after 1m0s
[20:39:37.752] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:83:0)
[20:39:37.752] Timer tick, asking Buildbucket for the build status
[20:39:38.042] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:38.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:84:0) after 1m0s
[20:40:38.166] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:84:0)
[20:40:38.166] Timer tick, asking Buildbucket for the build status
[20:40:38.321] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:38.321] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:85:0) after 1m0s
[20:41:38.368] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:85:0)
[20:41:38.368] Timer tick, asking Buildbucket for the build status
[20:41:38.542] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:38.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:86:0) after 1m0s
[20:42:38.662] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:86:0)
[20:42:38.662] Timer tick, asking Buildbucket for the build status
[20:42:38.970] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:38.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:87:0) after 1m0s
[20:43:39.061] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:87:0)
[20:43:39.061] Timer tick, asking Buildbucket for the build status
[20:43:39.217] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:39.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:88:0) after 1m0s
[20:44:39.284] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:88:0)
[20:44:39.284] Timer tick, asking Buildbucket for the build status
[20:44:39.757] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:39.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:89:0) after 1m0s
[20:45:39.842] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:89:0)
[20:45:39.842] Timer tick, asking Buildbucket for the build status
[20:45:40.688] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:40.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:90:0) after 1m0s
[20:46:40.706] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:90:0)
[20:46:40.706] Timer tick, asking Buildbucket for the build status
[20:46:41.013] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:41.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:91:0) after 1m0s
[20:47:41.117] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:91:0)
[20:47:41.117] Timer tick, asking Buildbucket for the build status
[20:47:41.248] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:41.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:92:0) after 1m0s
[20:48:41.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:92:0)
[20:48:41.275] Timer tick, asking Buildbucket for the build status
[20:48:41.435] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:41.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:93:0) after 1m0s
[20:49:41.498] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:93:0)
[20:49:41.498] Timer tick, asking Buildbucket for the build status
[20:49:41.975] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:41.975] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:94:0) after 1m0s
[20:50:42.006] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:94:0)
[20:50:42.006] Timer tick, asking Buildbucket for the build status
[20:50:42.235] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:42.235] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:95:0) after 1m0s
[20:51:42.302] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:95:0)
[20:51:42.302] Timer tick, asking Buildbucket for the build status
[20:51:42.490] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:42.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:96:0) after 1m0s
[20:52:42.514] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:96:0)
[20:52:42.514] Timer tick, asking Buildbucket for the build status
[20:52:42.795] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:42.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:97:0) after 1m0s
[20:53:42.817] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:97:0)
[20:53:42.817] Timer tick, asking Buildbucket for the build status
[20:53:43.569] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:43.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:98:0) after 1m0s
[20:54:43.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:98:0)
[20:54:43.597] Timer tick, asking Buildbucket for the build status
[20:54:43.914] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:43.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:99:0) after 1m0s
[20:55:43.944] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:99:0)
[20:55:43.944] Timer tick, asking Buildbucket for the build status
[20:55:44.697] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:44.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:100:0) after 1m0s
[20:56:44.724] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:100:0)
[20:56:44.724] Timer tick, asking Buildbucket for the build status
[20:56:44.881] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:44.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:101:0) after 1m0s
[20:57:44.912] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:101:0)
[20:57:44.912] Timer tick, asking Buildbucket for the build status
[20:57:45.548] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:45.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:102:0) after 1m0s
[20:58:45.573] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:102:0)
[20:58:45.573] Timer tick, asking Buildbucket for the build status
[20:58:45.709] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:45.709] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:103:0) after 1m0s
[20:59:45.729] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:103:0)
[20:59:45.729] Timer tick, asking Buildbucket for the build status
[20:59:45.932] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:45.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:104:0) after 1m0s
[21:00:45.972] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:104:0)
[21:00:45.972] Timer tick, asking Buildbucket for the build status
[21:00:46.153] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:46.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:105:0) after 1m0s
[21:01:46.177] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:105:0)
[21:01:46.177] Timer tick, asking Buildbucket for the build status
[21:01:46.482] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:46.482] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:106:0) after 1m0s
[21:02:46.479] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:106:0)
[21:02:46.479] Timer tick, asking Buildbucket for the build status
[21:02:46.642] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:46.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:107:0) after 1m0s
[21:03:46.674] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:107:0)
[21:03:46.674] Timer tick, asking Buildbucket for the build status
[21:03:46.885] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:46.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:108:0) after 1m0s
[21:04:46.909] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:108:0)
[21:04:46.909] Timer tick, asking Buildbucket for the build status
[21:04:47.516] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:47.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:109:0) after 1m0s
[21:05:47.543] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:109:0)
[21:05:47.543] Timer tick, asking Buildbucket for the build status
[21:05:47.974] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:47.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:110:0) after 1m0s
[21:06:47.997] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:110:0)
[21:06:47.997] Timer tick, asking Buildbucket for the build status
[21:06:48.274] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:48.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:111:0) after 1m0s
[21:07:48.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:111:0)
[21:07:48.317] Timer tick, asking Buildbucket for the build status
[21:07:48.662] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:48.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:112:0) after 1m0s
[21:08:48.753] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:112:0)
[21:08:48.753] Timer tick, asking Buildbucket for the build status
[21:08:48.903] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:48.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:113:0) after 1m0s
[21:09:48.912] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:113:0)
[21:09:48.912] Timer tick, asking Buildbucket for the build status
[21:09:49.377] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:49.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:114:0) after 1m0s
[21:10:49.552] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:114:0)
[21:10:49.552] Timer tick, asking Buildbucket for the build status
[21:10:49.742] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:49.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:115:0) after 1m0s
[21:11:49.740] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:115:0)
[21:11:49.741] Timer tick, asking Buildbucket for the build status
[21:11:50.027] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:50.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:116:0) after 1m0s
[21:12:50.057] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:116:0)
[21:12:50.057] Timer tick, asking Buildbucket for the build status
[21:12:50.295] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:50.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:117:0) after 1m0s
[21:13:50.337] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:117:0)
[21:13:50.337] Timer tick, asking Buildbucket for the build status
[21:13:50.682] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:50.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:118:0) after 1m0s
[21:14:50.713] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:118:0)
[21:14:50.713] Timer tick, asking Buildbucket for the build status
[21:14:51.172] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:51.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:119:0) after 1m0s
[21:15:51.280] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:119:0)
[21:15:51.280] Timer tick, asking Buildbucket for the build status
[21:15:51.535] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:51.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:120:0) after 1m0s
[21:16:51.530] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:120:0)
[21:16:51.530] Timer tick, asking Buildbucket for the build status
[21:16:51.789] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:51.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:121:0) after 1m0s
[21:17:51.886] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:121:0)
[21:17:51.886] Timer tick, asking Buildbucket for the build status
[21:17:52.017] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:52.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:122:0) after 1m0s
[21:18:52.037] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:122:0)
[21:18:52.037] Timer tick, asking Buildbucket for the build status
[21:18:52.236] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:52.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:123:0) after 1m0s
[21:19:52.521] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:123:0)
[21:19:52.521] Timer tick, asking Buildbucket for the build status
[21:19:52.698] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:52.698] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:124:0) after 1m0s
[21:20:52.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:124:0)
[21:20:52.950] Timer tick, asking Buildbucket for the build status
[21:20:53.524] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:53.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:125:0) after 1m0s
[21:21:54.119] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:125:0)
[21:21:54.119] Timer tick, asking Buildbucket for the build status
[21:21:54.315] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:54.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:126:0) after 1m0s
[21:22:54.385] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:126:0)
[21:22:54.385] Timer tick, asking Buildbucket for the build status
[21:22:54.553] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:54.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:127:0) after 1m0s
[21:23:54.754] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:127:0)
[21:23:54.754] Timer tick, asking Buildbucket for the build status
[21:23:54.946] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:54.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:128:0) after 1m0s
[21:24:55.068] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:128:0)
[21:24:55.068] Timer tick, asking Buildbucket for the build status
[21:24:55.247] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:55.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:129:0) after 1m0s
[21:25:55.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:129:0)
[21:25:55.336] Timer tick, asking Buildbucket for the build status
[21:25:55.750] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:55.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:130:0) after 1m0s
[21:26:55.874] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:130:0)
[21:26:55.874] Timer tick, asking Buildbucket for the build status
[21:26:56.045] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:56.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:131:0) after 1m0s
[21:27:56.068] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:131:0)
[21:27:56.068] Timer tick, asking Buildbucket for the build status
[21:27:56.218] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:56.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:132:0) after 1m0s
[21:28:56.342] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:132:0)
[21:28:56.342] Timer tick, asking Buildbucket for the build status
[21:28:56.878] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:56.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:133:0) after 1m0s
[21:30:02.330] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:133:0)
[21:30:02.330] Timer tick, asking Buildbucket for the build status
[21:30:02.501] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:02.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:134:0) after 1m0s
[21:31:02.674] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:134:0)
[21:31:02.674] Timer tick, asking Buildbucket for the build status
[21:31:02.891] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:02.891] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:135:0) after 1m0s
[21:32:03.011] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:135:0)
[21:32:03.011] Timer tick, asking Buildbucket for the build status
[21:32:03.163] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:03.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:136:0) after 1m0s
[21:33:03.249] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:136:0)
[21:33:03.249] Timer tick, asking Buildbucket for the build status
[21:33:04.002] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:04.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:137:0) after 1m0s
[21:34:04.182] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:137:0)
[21:34:04.182] Timer tick, asking Buildbucket for the build status
[21:34:04.311] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:04.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:138:0) after 1m0s
[21:35:04.623] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:138:0)
[21:35:04.623] Timer tick, asking Buildbucket for the build status
[21:35:04.747] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:04.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:139:0) after 1m0s
[21:36:04.816] Handling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:139:0)
[21:36:04.816] Timer tick, asking Buildbucket for the build status
[21:36:05.387] Build 8890174136745774736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:05.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOS:9055604198846450752:140:0) after 1m0s
[21:36:28.690] Received PubSub notification, asking Buildbucket for the build status
[21:36:28.782] Build 8890174136745774736: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:36:28.782] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1580074587654022",
"created_by": "project:chromium",
"created_ts": "1580066279614521",
"failure_reason": "BUILD_FAILURE",
"id": "8890174136745774736",
"parameters_json": "{\"builder_name\": \"ToTiOS\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4151601c15f976722bed73a8b2783e0962df72e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed ios_chrome_unittests (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\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOS\", \"buildnumber\": 12044, \"got_angle_revision\": \"fcef6dcb6ab246bc5a3519cf3e8ca281315a6e63\", \"got_dawn_revision\": \"d26ee85fba6d511eff4362f5b72eaca2dd36657c\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"e4151601c15f976722bed73a8b2783e0962df72e\", \"got_revision_cp\": \"refs/heads/master@{#735296}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"748ad200897b5023ba16e527aa1221400f90b4fe\", \"got_v8_revision\": \"ded3dd5b397722ce87c787130cc352afe9f8e35e\", \"got_v8_revision_cp\": \"refs/heads/8.1.281@{#1}\", \"got_webrtc_revision\": \"760fd5249488a7a8698679a026b247423caa7cce\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30366}\", \"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\": \"e4151601c15f976722bed73a8b2783e0962df72e\", \"swarm_hashes\": {\"0\": \"5ab8806048ad8d668ea49c2dde12336cbe070ca7\", \"1\": \"ce235b54be3af85945fe325367e3d010113e8e0e\", \"10\": \"e809048c90bbed6e3ca537f4c47493416210ad40\", \"11\": \"6751fbd69038ae56d2f6bde2367223370c1659bf\", \"12\": \"98734c3398d0763398f4da735a307f6d3405a2ba\", \"13\": \"b90d9b2b0c719cdf780f21c16bac7ba565fe8c2b\", \"14\": \"9a8f463ed9e6c00cc9387a2a9cd5e92420cfc556\", \"15\": \"04f09eb591902b4b5fc22fa9a38b3684b901c468\", \"16\": \"cd04feadc4804e606dff747fa09dfde63ca308ab\", \"2\": \"a11262c284a8196821fd341d6114dd6206038644\", \"3\": \"62189230921117c0a20ccc72dddfea3e0289e91c\", \"4\": \"9a077a2b6363208811819bef602c58d65a0ef30c\", \"5\": \"65b643d05bf676343ae21898cd5872cc98a4f21b\", \"6\": \"c6f72c3c2881f3ccb91d4b645144f3892e8ada55\", \"7\": \"aae17cb71a209555ed0a33728bf0e4786287ae72\", \"8\": \"deee105e2bdfa0101e480e27701f12381a299337\", \"9\": \"7ed5c61e2bbdeef908b1838fe12ecac9580cf227\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0c96c161cf7dd2e1c2b922319da904a0c0164c4adceed5a8844a45f1c516ad13_v2\", \"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"git\", \"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\": [\"build282-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\": [\"4792-2014df3\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed ios_chrome_unittests (iPhone 6s iOS 12.2).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580066459537609",
"status": "COMPLETED",
"status_changed_ts": "1580066459935486",
"tags": [
"build_address:luci.chromium.ci/ToTiOS/12044",
"builder:ToTiOS",
"buildset:commit/git/e4151601c15f976722bed73a8b2783e0962df72e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4151601c15f976722bed73a8b2783e0962df72e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9055604198846450752",
"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/8890174136745774736/+/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:49fc1b9c72fa8a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1580074588145041",
"url": "https://ci.chromium.org/b/8890174136745774736",
"utcnow_ts": "1580074588775424"
}
}
[21:36:28.782] Invocation finished in 2h18m30.554618249s with status FAILED