[06:52:44.596] New invocation is queued and will start shortly
[06:52:45.929] Starting the invocation (attempt 1)
[06:52:46.007] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:52:46.007] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:52:46.008] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9065616750809650928",
"parameters_json": "{\"builder_name\":\"ToTiOSDevice\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"24617a01b22b34d09d81e19b99cd2aa25566a488\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTiOSDevice",
"scheduler_invocation_id:9065616750809650928",
"scheduler_job_id:chromium/ToTiOSDevice",
"user_agent:luci-scheduler",
"buildset:commit/git/24617a01b22b34d09d81e19b99cd2aa25566a488",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/24617a01b22b34d09d81e19b99cd2aa25566a488",
"gitiles_ref:refs/heads/master"
]
}
[06:52:46.953] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1570517566225301",
"id": "8900186688435880160",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"24617a01b22b34d09d81e19b99cd2aa25566a488\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1570517566749523",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/14473",
"builder:ToTiOSDevice",
"buildset:commit/git/24617a01b22b34d09d81e19b99cd2aa25566a488",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/24617a01b22b34d09d81e19b99cd2aa25566a488",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065616750809650928",
"scheduler_job_id:chromium/ToTiOSDevice",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8900186688435880160/+/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": "1570517566749668",
"url": "https://ci.chromium.org/b/8900186688435880160",
"utcnow_ts": "1570517566946738"
}
}
[06:52:46.953] Task URL: https://ci.chromium.org/b/8900186688435880160
[06:52:46.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:2:0) after 1m0s
[06:53:47.198] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:2:0)
[06:53:47.198] Timer tick, asking Buildbucket for the build status
[06:53:47.905] Build 8900186688435880160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:53:47.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:3:0) after 1m0s
[06:54:47.950] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:3:0)
[06:54:47.950] Timer tick, asking Buildbucket for the build status
[06:54:48.189] Build 8900186688435880160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:54:48.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:4:0) after 1m0s
[06:55:45.286] Received PubSub notification, asking Buildbucket for the build status
[06:55:46.593] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:48.277] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:4:0)
[06:55:48.277] Timer tick, asking Buildbucket for the build status
[06:55:50.588] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:50.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:6:0) after 1m0s
[06:56:50.688] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:6:0)
[06:56:50.688] Timer tick, asking Buildbucket for the build status
[06:56:50.991] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:50.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:7:0) after 1m0s
[06:57:51.087] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:7:0)
[06:57:51.087] Timer tick, asking Buildbucket for the build status
[06:57:54.102] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:54.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:8:0) after 1m0s
[06:58:54.359] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:8:0)
[06:58:54.359] Timer tick, asking Buildbucket for the build status
[06:58:54.548] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:54.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:9:0) after 1m0s
[06:59:54.574] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:9:0)
[06:59:54.574] Timer tick, asking Buildbucket for the build status
[06:59:54.869] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:54.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:10:0) after 1m0s
[07:01:06.878] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:10:0)
[07:01:06.878] Timer tick, asking Buildbucket for the build status
[07:01:21.092] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:21.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:11:0) after 1m0s
[07:02:21.225] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:11:0)
[07:02:21.225] Timer tick, asking Buildbucket for the build status
[07:02:33.353] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:33.353] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:12:0) after 1m0s
[07:03:33.771] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:12:0)
[07:03:33.771] Timer tick, asking Buildbucket for the build status
[07:03:35.944] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:35.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:13:0) after 1m0s
[07:04:36.255] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:13:0)
[07:04:36.255] Timer tick, asking Buildbucket for the build status
[07:04:36.473] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:36.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:14:0) after 1m0s
[07:05:36.597] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:14:0)
[07:05:36.597] Timer tick, asking Buildbucket for the build status
[07:05:38.046] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:38.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:15:0) after 1m0s
[07:06:38.157] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:15:0)
[07:06:38.157] Timer tick, asking Buildbucket for the build status
[07:06:38.974] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:38.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:16:0) after 1m0s
[07:07:39.036] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:16:0)
[07:07:39.036] Timer tick, asking Buildbucket for the build status
[07:07:41.691] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:41.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:17:0) after 1m0s
[07:08:41.996] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:17:0)
[07:08:41.996] Timer tick, asking Buildbucket for the build status
[07:08:42.551] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:42.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:18:0) after 1m0s
[07:09:42.611] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:18:0)
[07:09:42.611] Timer tick, asking Buildbucket for the build status
[07:09:45.784] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:45.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:19:0) after 1m0s
[07:10:45.851] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:19:0)
[07:10:45.851] Timer tick, asking Buildbucket for the build status
[07:10:46.045] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:46.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:20:0) after 1m0s
[07:11:46.100] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:20:0)
[07:11:46.100] Timer tick, asking Buildbucket for the build status
[07:11:46.962] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:46.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:21:0) after 1m0s
[07:12:46.997] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:21:0)
[07:12:46.997] Timer tick, asking Buildbucket for the build status
[07:12:47.214] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:47.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:22:0) after 1m0s
[07:13:47.315] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:22:0)
[07:13:47.315] Timer tick, asking Buildbucket for the build status
[07:13:49.047] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:49.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:23:0) after 1m0s
[07:14:49.084] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:23:0)
[07:14:49.084] Timer tick, asking Buildbucket for the build status
[07:14:49.814] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:49.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:24:0) after 1m0s
[07:15:49.915] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:24:0)
[07:15:49.915] Timer tick, asking Buildbucket for the build status
[07:15:52.655] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:52.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:25:0) after 1m0s
[07:16:52.712] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:25:0)
[07:16:52.712] Timer tick, asking Buildbucket for the build status
[07:16:53.729] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:53.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:26:0) after 1m0s
[07:17:53.817] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:26:0)
[07:17:53.817] Timer tick, asking Buildbucket for the build status
[07:17:54.913] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:54.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:27:0) after 1m0s
[07:18:55.095] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:27:0)
[07:18:55.095] Timer tick, asking Buildbucket for the build status
[07:18:56.087] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:56.087] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:28:0) after 1m0s
[07:19:56.135] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:28:0)
[07:19:56.135] Timer tick, asking Buildbucket for the build status
[07:19:56.359] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:56.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:29:0) after 1m0s
[07:20:56.516] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:29:0)
[07:20:56.516] Timer tick, asking Buildbucket for the build status
[07:20:57.114] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:57.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:30:0) after 1m0s
[07:21:57.150] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:30:0)
[07:21:57.150] Timer tick, asking Buildbucket for the build status
[07:21:57.463] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:57.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:31:0) after 1m0s
[07:22:57.490] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:31:0)
[07:22:57.490] Timer tick, asking Buildbucket for the build status
[07:22:59.155] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:59.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:32:0) after 1m0s
[07:23:59.578] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:32:0)
[07:23:59.578] Timer tick, asking Buildbucket for the build status
[07:24:00.717] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:00.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:33:0) after 1m0s
[07:25:01.386] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:33:0)
[07:25:01.386] Timer tick, asking Buildbucket for the build status
[07:25:02.531] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:02.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:34:0) after 1m0s
[07:26:02.602] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:34:0)
[07:26:02.602] Timer tick, asking Buildbucket for the build status
[07:26:03.382] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:03.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:35:0) after 1m0s
[07:27:03.409] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:35:0)
[07:27:03.409] Timer tick, asking Buildbucket for the build status
[07:27:04.942] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:04.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:36:0) after 1m0s
[07:28:05.074] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:36:0)
[07:28:05.074] Timer tick, asking Buildbucket for the build status
[07:28:07.958] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:07.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:37:0) after 1m0s
[07:29:08.178] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:37:0)
[07:29:08.178] Timer tick, asking Buildbucket for the build status
[07:29:12.198] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:12.198] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:38:0) after 1m0s
[07:30:12.317] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:38:0)
[07:30:12.317] Timer tick, asking Buildbucket for the build status
[07:30:13.211] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:13.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:39:0) after 1m0s
[07:31:13.218] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:39:0)
[07:31:13.218] Timer tick, asking Buildbucket for the build status
[07:31:13.469] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:13.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:40:0) after 1m0s
[07:32:13.555] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:40:0)
[07:32:13.555] Timer tick, asking Buildbucket for the build status
[07:32:14.410] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:14.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:41:0) after 1m0s
[07:33:14.552] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:41:0)
[07:33:14.552] Timer tick, asking Buildbucket for the build status
[07:33:15.830] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:15.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:42:0) after 1m0s
[07:34:16.028] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:42:0)
[07:34:16.028] Timer tick, asking Buildbucket for the build status
[07:34:16.278] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:16.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:43:0) after 1m0s
[07:35:16.611] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:43:0)
[07:35:16.611] Timer tick, asking Buildbucket for the build status
[07:35:17.205] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:17.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:44:0) after 1m0s
[07:36:17.275] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:44:0)
[07:36:17.275] Timer tick, asking Buildbucket for the build status
[07:36:17.445] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:17.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:45:0) after 1m0s
[07:37:17.650] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:45:0)
[07:37:17.650] Timer tick, asking Buildbucket for the build status
[07:37:19.370] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:19.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:46:0) after 1m0s
[07:38:19.904] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:46:0)
[07:38:19.904] Timer tick, asking Buildbucket for the build status
[07:38:20.816] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:20.816] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:47:0) after 1m0s
[07:39:21.062] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:47:0)
[07:39:21.062] Timer tick, asking Buildbucket for the build status
[07:39:21.594] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:21.594] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:48:0) after 1m0s
[07:40:21.783] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:48:0)
[07:40:21.783] Timer tick, asking Buildbucket for the build status
[07:40:22.005] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:22.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:49:0) after 1m0s
[07:41:22.223] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:49:0)
[07:41:22.223] Timer tick, asking Buildbucket for the build status
[07:41:22.476] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:22.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:50:0) after 1m0s
[07:42:22.554] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:50:0)
[07:42:22.554] Timer tick, asking Buildbucket for the build status
[07:42:22.884] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:22.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:51:0) after 1m0s
[07:43:23.024] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:51:0)
[07:43:23.024] Timer tick, asking Buildbucket for the build status
[07:43:23.804] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:23.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:52:0) after 1m0s
[07:44:23.963] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:52:0)
[07:44:23.963] Timer tick, asking Buildbucket for the build status
[07:44:24.813] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:24.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:53:0) after 1m0s
[07:45:24.986] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:53:0)
[07:45:24.986] Timer tick, asking Buildbucket for the build status
[07:45:25.422] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:25.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:54:0) after 1m0s
[07:46:25.485] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:54:0)
[07:46:25.485] Timer tick, asking Buildbucket for the build status
[07:46:25.855] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:25.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:55:0) after 1m0s
[07:47:25.979] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:55:0)
[07:47:25.979] Timer tick, asking Buildbucket for the build status
[07:47:26.713] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:26.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:56:0) after 1m0s
[07:48:26.838] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:56:0)
[07:48:26.838] Timer tick, asking Buildbucket for the build status
[07:48:27.009] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:27.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:57:0) after 1m0s
[07:49:27.273] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:57:0)
[07:49:27.273] Timer tick, asking Buildbucket for the build status
[07:49:28.177] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:28.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:58:0) after 1m0s
[07:50:28.395] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:58:0)
[07:50:28.395] Timer tick, asking Buildbucket for the build status
[07:50:28.542] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:28.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:59:0) after 1m0s
[07:51:28.703] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:59:0)
[07:51:28.703] Timer tick, asking Buildbucket for the build status
[07:51:29.429] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:29.429] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:60:0) after 1m0s
[07:52:29.475] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:60:0)
[07:52:29.475] Timer tick, asking Buildbucket for the build status
[07:52:29.681] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:29.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:61:0) after 1m0s
[07:53:29.856] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:61:0)
[07:53:29.856] Timer tick, asking Buildbucket for the build status
[07:53:35.421] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:35.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:62:0) after 1m0s
[07:54:35.592] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:62:0)
[07:54:35.592] Timer tick, asking Buildbucket for the build status
[07:54:36.346] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:36.346] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:63:0) after 1m0s
[07:55:36.697] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:63:0)
[07:55:36.697] Timer tick, asking Buildbucket for the build status
[07:55:36.845] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:36.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:64:0) after 1m0s
[07:56:37.133] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:64:0)
[07:56:37.133] Timer tick, asking Buildbucket for the build status
[07:56:39.771] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:39.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:65:0) after 1m0s
[07:57:40.179] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:65:0)
[07:57:40.179] Timer tick, asking Buildbucket for the build status
[07:57:40.535] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:40.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:66:0) after 1m0s
[07:58:40.923] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:66:0)
[07:58:40.923] Timer tick, asking Buildbucket for the build status
[07:58:43.703] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:43.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:67:0) after 1m0s
[07:59:43.742] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:67:0)
[07:59:43.742] Timer tick, asking Buildbucket for the build status
[07:59:45.417] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:45.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:68:0) after 1m0s
[08:00:45.535] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:68:0)
[08:00:45.535] Timer tick, asking Buildbucket for the build status
[08:00:46.306] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:46.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:69:0) after 1m0s
[08:01:46.417] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:69:0)
[08:01:46.417] Timer tick, asking Buildbucket for the build status
[08:01:47.204] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:47.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:70:0) after 1m0s
[08:02:47.233] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:70:0)
[08:02:47.233] Timer tick, asking Buildbucket for the build status
[08:02:47.433] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:47.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:71:0) after 1m0s
[08:03:47.437] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:71:0)
[08:03:47.437] Timer tick, asking Buildbucket for the build status
[08:03:47.738] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:47.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:72:0) after 1m0s
[08:04:47.766] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:72:0)
[08:04:47.766] Timer tick, asking Buildbucket for the build status
[08:04:49.637] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:49.637] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:73:0) after 1m0s
[08:05:49.665] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:73:0)
[08:05:49.665] Timer tick, asking Buildbucket for the build status
[08:05:51.259] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:51.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:74:0) after 1m0s
[08:06:51.336] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:74:0)
[08:06:51.336] Timer tick, asking Buildbucket for the build status
[08:06:53.598] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:53.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:75:0) after 1m0s
[08:07:53.686] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:75:0)
[08:07:53.686] Timer tick, asking Buildbucket for the build status
[08:07:54.433] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:54.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:76:0) after 1m0s
[08:08:54.411] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:76:0)
[08:08:54.411] Timer tick, asking Buildbucket for the build status
[08:08:56.591] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:56.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:77:0) after 1m0s
[08:09:56.669] Handling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:77:0)
[08:09:56.669] Timer tick, asking Buildbucket for the build status
[08:09:56.867] Build 8900186688435880160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:56.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTiOSDevice:9065616750809650928:78:0) after 1m0s
[08:10:44.532] Received PubSub notification, asking Buildbucket for the build status
[08:10:44.662] Build 8900186688435880160: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:10:44.662] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1570522241804429",
"created_by": "project:chromium",
"created_ts": "1570517566225301",
"failure_reason": "BUILD_FAILURE",
"id": "8900186688435880160",
"parameters_json": "{\"builder_name\": \"ToTiOSDevice\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"24617a01b22b34d09d81e19b99cd2aa25566a488\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Failed components_unittests (iPhone 6s iOS 12.3.1), ios_chrome_unittests (iPhone 6s iOS 12.3.1), net_unittests (iPhone 6s iOS 12.3.1).\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"build282-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTiOSDevice\", \"buildnumber\": 14473, \"got_angle_revision\": \"a333b87cfcbe26daa7760aa710234c8e999d9ba5\", \"got_dawn_revision\": \"8eb8385e2efc6b4cc5e1d77fa888a64d9d6b0511\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"24617a01b22b34d09d81e19b99cd2aa25566a488\", \"got_revision_cp\": \"refs/heads/master@{#703609}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"0d7c56dbb2845a42d527e247d91d5ee69b843389\", \"got_v8_revision_cp\": \"refs/heads/7.9.230@{#1}\", \"got_webrtc_revision\": \"a639f7a2447777d126b25bdf1536c22e3f698c49\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29397}\", \"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\": \"24617a01b22b34d09d81e19b99cd2aa25566a488\", \"swarm_hashes\": {\"0\": \"90d71d01616befb5b9c199a196cd3d13ae70fc4e\", \"1\": \"b61059b926fbb8f9961655e3d847ea9abed91c25\", \"10\": \"07a234891367b241328f6bf122f7c3490b3e294c\", \"11\": \"6ab9e44c9dd0dc5cc40eba8750200ed4e2cd09af\", \"12\": \"859002fa70158a3434e3836eb74afd05af324b49\", \"13\": \"bcfd3de2890ed8a1944d32779259d16b333c4f4f\", \"14\": \"885d7dfc618acbb32f855092c2a3d0c698435464\", \"15\": \"9d5315a414e98ae27e0f6e8d5e62f51b32153a1d\", \"16\": \"f0c18fad6a639eb92ad0bc9c754ef75759247b81\", \"2\": \"2a5d3e43a3ad98a26ab94c96f35e534671c19d5c\", \"3\": \"ddaa950038e8f35d1f9c5e43cebd2cc377a032e5\", \"4\": \"8ff342c2fc4bb6169ac5559c94a0b20d0d525b63\", \"5\": \"8cbc91a75d5074281ebe6acf5c4d1684ef8f2060\", \"6\": \"50df9108b8dcc9ae3a8eb39fe64a9e0fd7949e24\", \"7\": \"dad2e09b0f9d0a7cc16a88b4b5f0ed4cb79bee63\", \"8\": \"f7996da89ad54d3ace5e05024723e6b33f8fc3e0\", \"9\": \"619d48dbf9616ecc87868ff70fc424b4f68954c1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a4feefdd7e355061708c01720b06a0ca8c49ffc9968a2ebc674541738676b8f_v2\", \"builder_5372538a354f163a20d332d881c6c5d85e35654ac8a57c760866f12033f8a8a5_v2\", \"builder_ae5debd901c74ee0906916cb62621bceb2a8b657b42c2e2e9e89a0f6a2e5e53b_v2\", \"builder_d42b89eab403033f5a2a8102ec9c436397350cedb439d5e09b11874a5784adb4_v2\", \"git\", \"goma_v2\", \"vpython\", \"xcode_ios_11a420a\"], \"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\": [\"4466-755d6a2\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}, \"ui\": {\"info\": \"Failed components_unittests (iPhone 6s iOS 12.3.1), ios_chrome_unittests (iPhone 6s iOS 12.3.1), net_unittests (iPhone 6s iOS 12.3.1).\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1570517743814497",
"status": "COMPLETED",
"status_changed_ts": "1570517744570211",
"tags": [
"build_address:luci.chromium.ci/ToTiOSDevice/14473",
"builder:ToTiOSDevice",
"buildset:commit/git/24617a01b22b34d09d81e19b99cd2aa25566a488",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/24617a01b22b34d09d81e19b99cd2aa25566a488",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065616750809650928",
"scheduler_job_id:chromium/ToTiOSDevice",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8900186688435880160/+/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:47c2f6022c3c8210",
"user_agent:luci-scheduler"
],
"updated_ts": "1570522243539278",
"url": "https://ci.chromium.org/b/8900186688435880160",
"utcnow_ts": "1570522244654974"
}
}
[08:10:44.662] Invocation finished in 1h18m0.084584163s with status FAILED