[17:35:26.248] New invocation is queued and will start shortly
[17:35:27.338] Starting the invocation (attempt 1)
[17:35:27.377] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:35:27.377] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:35:27.377] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9075088997459188704",
"parameters_json": "{\"builder_name\":\"android-code-coverage\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"8370e6d6637ba8e89a0d32b8bf31bd1cfbe86c12\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-code-coverage",
"scheduler_invocation_id:9075088997459188704",
"scheduler_job_id:chromium/android-code-coverage",
"user_agent:luci-scheduler",
"buildset:commit/git/8370e6d6637ba8e89a0d32b8bf31bd1cfbe86c12",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8370e6d6637ba8e89a0d32b8bf31bd1cfbe86c12",
"gitiles_ref:refs/heads/master"
]
}
[17:35:28.745] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1561484127633048",
"id": "8909658935340874784",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8370e6d6637ba8e89a0d32b8bf31bd1cfbe86c12\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1561484128283464",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/1545",
"builder:android-code-coverage",
"buildset:commit/git/8370e6d6637ba8e89a0d32b8bf31bd1cfbe86c12",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8370e6d6637ba8e89a0d32b8bf31bd1cfbe86c12",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075088997459188704",
"scheduler_job_id:chromium/android-code-coverage",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8909658935340874784/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1561484128283556",
"url": "https://ci.chromium.org/b/8909658935340874784",
"utcnow_ts": "1561484128696441"
}
}
[17:35:28.745] Task URL: https://ci.chromium.org/b/8909658935340874784
[17:35:28.745] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:2:0) after 1m0s
[17:36:28.783] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:2:0)
[17:36:28.783] Timer tick, asking Buildbucket for the build status
[17:36:28.944] Build 8909658935340874784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:36:28.944] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:3:0) after 1m0s
[17:36:43.204] Received PubSub notification, asking Buildbucket for the build status
[17:36:43.919] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:28.967] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:3:0)
[17:37:28.967] Timer tick, asking Buildbucket for the build status
[17:37:29.162] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:29.162] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:5:0) after 1m0s
[17:38:29.241] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:5:0)
[17:38:29.241] Timer tick, asking Buildbucket for the build status
[17:38:29.991] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:29.991] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:6:0) after 1m0s
[17:39:30.074] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:6:0)
[17:39:30.074] Timer tick, asking Buildbucket for the build status
[17:39:30.308] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:30.308] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:7:0) after 1m0s
[17:40:30.485] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:7:0)
[17:40:30.485] Timer tick, asking Buildbucket for the build status
[17:40:30.636] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:30.636] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:8:0) after 1m0s
[17:41:30.638] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:8:0)
[17:41:30.638] Timer tick, asking Buildbucket for the build status
[17:41:31.536] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:31.536] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:9:0) after 1m0s
[17:42:31.553] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:9:0)
[17:42:31.553] Timer tick, asking Buildbucket for the build status
[17:42:31.960] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:31.960] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:10:0) after 1m0s
[17:43:31.976] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:10:0)
[17:43:31.976] Timer tick, asking Buildbucket for the build status
[17:43:32.868] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:32.868] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:11:0) after 1m0s
[17:44:33.029] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:11:0)
[17:44:33.029] Timer tick, asking Buildbucket for the build status
[17:44:33.147] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:33.147] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:12:0) after 1m0s
[17:45:33.276] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:12:0)
[17:45:33.276] Timer tick, asking Buildbucket for the build status
[17:45:33.783] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:33.783] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:13:0) after 1m0s
[17:46:33.843] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:13:0)
[17:46:33.843] Timer tick, asking Buildbucket for the build status
[17:46:33.963] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:33.963] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:14:0) after 1m0s
[17:47:34.052] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:14:0)
[17:47:34.052] Timer tick, asking Buildbucket for the build status
[17:47:34.594] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:34.594] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:15:0) after 1m0s
[17:48:34.812] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:15:0)
[17:48:34.812] Timer tick, asking Buildbucket for the build status
[17:48:35.279] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:35.279] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:16:0) after 1m0s
[17:49:35.582] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:16:0)
[17:49:35.582] Timer tick, asking Buildbucket for the build status
[17:49:35.761] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:35.761] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:17:0) after 1m0s
[17:50:36.141] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:17:0)
[17:50:36.141] Timer tick, asking Buildbucket for the build status
[17:50:37.315] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:37.315] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:18:0) after 1m0s
[17:51:37.501] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:18:0)
[17:51:37.501] Timer tick, asking Buildbucket for the build status
[17:51:37.817] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:37.817] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:19:0) after 1m0s
[17:52:37.870] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:19:0)
[17:52:37.870] Timer tick, asking Buildbucket for the build status
[17:52:39.042] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:39.042] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:20:0) after 1m0s
[17:53:39.338] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:20:0)
[17:53:39.338] Timer tick, asking Buildbucket for the build status
[17:53:39.474] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:39.474] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:21:0) after 1m0s
[17:54:39.519] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:21:0)
[17:54:39.519] Timer tick, asking Buildbucket for the build status
[17:54:39.704] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:39.704] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:22:0) after 1m0s
[17:55:39.750] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:22:0)
[17:55:39.750] Timer tick, asking Buildbucket for the build status
[17:55:39.924] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:39.924] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:23:0) after 1m0s
[17:56:40.042] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:23:0)
[17:56:40.042] Timer tick, asking Buildbucket for the build status
[17:56:40.335] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:40.335] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:24:0) after 1m0s
[17:57:40.419] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:24:0)
[17:57:40.419] Timer tick, asking Buildbucket for the build status
[17:57:40.699] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:40.699] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:25:0) after 1m0s
[17:58:40.864] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:25:0)
[17:58:40.864] Timer tick, asking Buildbucket for the build status
[17:58:41.214] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:41.214] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:26:0) after 1m0s
[17:59:41.246] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:26:0)
[17:59:41.246] Timer tick, asking Buildbucket for the build status
[17:59:43.171] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:43.172] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:27:0) after 1m0s
[18:00:43.216] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:27:0)
[18:00:43.216] Timer tick, asking Buildbucket for the build status
[18:00:43.527] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:43.527] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:28:0) after 1m0s
[18:01:43.722] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:28:0)
[18:01:43.722] Timer tick, asking Buildbucket for the build status
[18:01:43.997] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:43.997] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:29:0) after 1m0s
[18:02:44.111] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:29:0)
[18:02:44.111] Timer tick, asking Buildbucket for the build status
[18:02:44.549] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:44.549] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:30:0) after 1m0s
[18:03:44.782] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:30:0)
[18:03:44.782] Timer tick, asking Buildbucket for the build status
[18:03:44.977] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:44.977] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:31:0) after 1m0s
[18:04:45.082] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:31:0)
[18:04:45.082] Timer tick, asking Buildbucket for the build status
[18:04:45.278] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:45.278] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:32:0) after 1m0s
[18:05:45.407] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:32:0)
[18:05:45.407] Timer tick, asking Buildbucket for the build status
[18:05:45.860] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:45.860] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:33:0) after 1m0s
[18:06:45.883] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:33:0)
[18:06:45.883] Timer tick, asking Buildbucket for the build status
[18:06:46.934] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:46.934] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:34:0) after 1m0s
[18:07:47.041] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:34:0)
[18:07:47.041] Timer tick, asking Buildbucket for the build status
[18:07:47.269] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:47.269] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:35:0) after 1m0s
[18:08:47.406] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:35:0)
[18:08:47.406] Timer tick, asking Buildbucket for the build status
[18:08:47.695] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:47.695] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:36:0) after 1m0s
[18:09:47.751] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:36:0)
[18:09:47.751] Timer tick, asking Buildbucket for the build status
[18:09:49.057] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:49.057] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:37:0) after 1m0s
[18:10:49.084] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:37:0)
[18:10:49.084] Timer tick, asking Buildbucket for the build status
[18:10:49.263] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:49.263] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:38:0) after 1m0s
[18:11:49.315] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:38:0)
[18:11:49.315] Timer tick, asking Buildbucket for the build status
[18:11:49.564] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:49.564] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:39:0) after 1m0s
[18:12:49.623] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:39:0)
[18:12:49.623] Timer tick, asking Buildbucket for the build status
[18:12:50.890] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:50.890] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:40:0) after 1m0s
[18:13:50.955] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:40:0)
[18:13:50.955] Timer tick, asking Buildbucket for the build status
[18:13:51.511] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:51.511] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:41:0) after 1m0s
[18:14:51.814] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:41:0)
[18:14:51.814] Timer tick, asking Buildbucket for the build status
[18:14:52.169] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:52.169] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:42:0) after 1m0s
[18:15:52.264] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:42:0)
[18:15:52.264] Timer tick, asking Buildbucket for the build status
[18:15:52.423] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:52.423] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:43:0) after 1m0s
[18:16:52.465] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:43:0)
[18:16:52.465] Timer tick, asking Buildbucket for the build status
[18:16:52.642] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:52.643] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:44:0) after 1m0s
[18:17:52.813] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:44:0)
[18:17:52.813] Timer tick, asking Buildbucket for the build status
[18:17:53.119] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:53.119] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:45:0) after 1m0s
[18:18:53.163] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:45:0)
[18:18:53.163] Timer tick, asking Buildbucket for the build status
[18:18:53.705] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:53.705] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:46:0) after 1m0s
[18:19:53.918] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:46:0)
[18:19:53.919] Timer tick, asking Buildbucket for the build status
[18:19:54.304] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:54.304] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:47:0) after 1m0s
[18:20:54.444] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:47:0)
[18:20:54.444] Timer tick, asking Buildbucket for the build status
[18:20:54.640] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:54.640] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:48:0) after 1m0s
[18:21:54.806] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:48:0)
[18:21:54.806] Timer tick, asking Buildbucket for the build status
[18:21:55.244] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:55.244] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:49:0) after 1m0s
[18:22:55.287] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:49:0)
[18:22:55.287] Timer tick, asking Buildbucket for the build status
[18:22:55.425] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:55.425] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:50:0) after 1m0s
[18:23:55.452] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:50:0)
[18:23:55.452] Timer tick, asking Buildbucket for the build status
[18:23:55.869] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:55.869] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:51:0) after 1m0s
[18:24:55.909] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:51:0)
[18:24:55.909] Timer tick, asking Buildbucket for the build status
[18:24:56.038] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:56.038] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:52:0) after 1m0s
[18:25:56.230] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:52:0)
[18:25:56.230] Timer tick, asking Buildbucket for the build status
[18:25:56.528] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:56.529] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:53:0) after 1m0s
[18:26:56.791] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:53:0)
[18:26:56.791] Timer tick, asking Buildbucket for the build status
[18:26:57.851] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:57.851] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:54:0) after 1m0s
[18:27:58.079] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:54:0)
[18:27:58.079] Timer tick, asking Buildbucket for the build status
[18:27:58.326] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:58.326] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:55:0) after 1m0s
[18:28:58.469] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:55:0)
[18:28:58.469] Timer tick, asking Buildbucket for the build status
[18:28:59.080] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:59.080] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:56:0) after 1m0s
[18:29:59.226] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:56:0)
[18:29:59.226] Timer tick, asking Buildbucket for the build status
[18:29:59.332] Build 8909658935340874784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:59.332] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075088997459188704:57:0) after 1m0s
[18:30:27.196] Received PubSub notification, asking Buildbucket for the build status
[18:30:27.728] Build 8909658935340874784: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:30:27.728] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1561487425776662",
"created_by": "project:chromium",
"created_ts": "1561484127633048",
"failure_reason": "BUILD_FAILURE",
"id": "8909658935340874784",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8370e6d6637ba8e89a0d32b8bf31bd1cfbe86c12\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 tests failed: ['latency_unittests on Android device Nexus 5X']\"}, \"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\": \"android-code-coverage-0-9ov0\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-code-coverage\", \"buildnumber\": 1545, \"got_angle_revision\": \"74e98f6cb07daf8b9c1d373013cc3b881f2be6c9\", \"got_dawn_revision\": \"41c24ee4eb6960c751993b85e7ff86f7431f449b\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"8370e6d6637ba8e89a0d32b8bf31bd1cfbe86c12\", \"got_revision_cp\": \"refs/heads/master@{#672134}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"0d7d36e8ecedadf49e7bb65844456f22a6920f28\", \"got_v8_revision_cp\": \"refs/heads/7.7.146@{#1}\", \"got_webrtc_revision\": \"5767fb8cbd2a966d2984c17f88bb3ef9c088356c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28370}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8370e6d6637ba8e89a0d32b8bf31bd1cfbe86c12\", \"swarm_hashes\": {\"android_webview_unittests\": \"8b71f1591f44c1304cf9b8633eb9718170bfc5f0\", \"angle_unittests\": \"7f3320afe99cec3c0092826aa3cf4ae114fcaa69\", \"base_unittests\": \"aa2eed63c0f3d6ee6f889f3b791278e4cf86b64c\", \"base_util_unittests\": \"4f1a94d0f73b7259f2059ec082138f01b44457d6\", \"blink_common_unittests\": \"4ac68252c50c9555d1c056ce86a549b9159d5797\", \"blink_heap_unittests\": \"5a406780ccf4015489412f61681945f2ee433e9b\", \"blink_platform_unittests\": \"a64f5a20151f7629b5728834dd083b0e7952f151\", \"blink_unittests\": \"6f99ef28485c7c386c51ba71334c4a117d30c680\", \"boringssl_crypto_tests\": \"7439a215f6c93077ea267c36ef031370f25989ba\", \"boringssl_ssl_tests\": \"8a5f73528ec512878bbc770a53f5c0236376a3b1\", \"breakpad_unittests\": \"7d4f0dbb2936e6677a50149449124eb51b4c64d6\", \"cacheinvalidation_unittests\": \"99e307a78254811af5cc86d4cd0cd326a91a6ce0\", \"capture_unittests\": \"c9a8c18c6459ac184fbf63972a6153aede1c11ab\", \"cast_unittests\": \"25e08c41c132d16337501361e0fd87544c523e13\", \"cc_unittests\": \"e4d81328fbad8cd8ee66160a44c949a4f7cd5fe1\", \"chrome_public_test_apk\": \"bc5c0713c658a755ec41240db19dde267e8cb63f\", \"chrome_public_test_vr_apk\": \"43d0e23e0245e6905f7cea4e193f5c1001d65cad\", \"components_browsertests\": \"138a338046e6efc7580fb7fcc9ae41f4eda71184\", \"components_unittests\": \"e3b14fb691913c3b77e8e6d91e0b1771a0b44e6b\", \"content_browsertests\": \"ee0c8b90f3984b32bc4410835e0ef4a97ffeeee2\", \"content_shell_test_apk\": \"081f1d1450475af9fa0c79977d58146f2129b8b4\", \"content_unittests\": \"736f1a0aff6b1e8882cc0bad150db3e7bce2ed65\", \"crypto_unittests\": \"4e950a700a52889655ba5b3b0d638084b745b744\", \"device_unittests\": \"0f9a4b663c78135fba32585f32172cd6e1ee6989\", \"display_unittests\": \"b8b99e8f570a616d4d0c4dd338c949ec23653bc5\", \"events_unittests\": \"23fe9226330fcbffa397b7742ea21d573093098e\", \"gcm_unit_tests\": \"4a96b37b166338c829270a11d48f74195839db2c\", \"gfx_unittests\": \"6c5674b1c93f9c4043b6a33747d3316b72172986\", \"gin_unittests\": \"aa5c6b0a6f2fbf6d7dc76de6fecba326fbebd0ee\", \"gl_tests\": \"e79b5f4d0161d65934a8719c2f559ae69ada9f9a\", \"gl_unittests\": \"53b9bb9582d12590d4a0c1e6b3c70dec0790de7c\", \"google_apis_unittests\": \"d7766d00a4ba4ae0c074a8fd275c4fd0351e4bbc\", \"gpu_unittests\": \"fde7be26fddd1c237e680f14ff6ed839242ea221\", \"ipc_tests\": \"b25081cf31a31a1fb95f4a6e3e4facaee7c89573\", \"jingle_unittests\": \"dfa92ab2537ae86a2a6fd0696d68eda3257241bf\", \"latency_unittests\": \"aa2164102a087ba071b0d967a52dd0a4e8cd213e\", \"libjingle_xmpp_unittests\": \"ec32da508e51e2adf3cac8982f962631f2b9523d\", \"media_blink_unittests\": \"709b987fb16f39107ddf473d24293c610853f5bc\", \"media_service_unittests\": \"f4cf66be68159bedc95db9720a8d9fa906d6d50f\", \"media_unittests\": \"8a18386d29724fec75e421e1d7df6317f096b212\", \"midi_unittests\": \"bcb593f30dc750aef1021751bcaeaf96988b21ed\", \"mojo_test_apk\": \"22665697e2dc6c645f514721f5c6c44165d98167\", \"mojo_unittests\": \"ee2897a6f6462e9508468f1292181be5a57ceabc\", \"net_unittests\": \"284e326f3f99cbe517f70b0bb4f5898013e9cbc3\", \"sandbox_linux_unittests\": \"f60cbcbd6537f1fab3a3dd8b0c8528d6e635ba90\", \"services_unittests\": \"16f1aedf16819e0d7c317246099691202f6df88d\", \"shell_dialogs_unittests\": \"c3495cb1903aa8957ddc3315f26d2c7e96741339\", \"skia_unittests\": \"cb880ef4caccdf2c4a62e12267a994ec3447dffb\", \"sql_unittests\": \"06ef5dff3a0e4df923fd3b9493344a0fb7ad429c\", \"storage_unittests\": \"84f56dd31a9d89b5e642b1e1f75126b96f0a49cd\", \"ui_android_unittests\": \"7127e03467c8656009aa67118ecba347cba5e640\", \"ui_base_unittests\": \"823be2d713fd9c3adf3f71be76573d3ce3a5cb1c\", \"ui_touch_selection_unittests\": \"94ae401cdea278a53d20fe88c9978e5c74675f76\", \"unit_tests\": \"ac9a69877ed1d1b651745512533ca629536715c8\", \"url_unittests\": \"402733471a2e0cb891a54ca7590381927b1901a2\", \"viz_unittests\": \"80740f08bf2fa8f4a07f944b4182dcd1684f7e3a\", \"vr_android_unittests\": \"9650232ce2b465bacf082248533d57f1b278e149\", \"vr_common_unittests\": \"a78dd81f99c58d58afcd8db3ce57466d976442dd\", \"vr_pixeltests\": \"d40e8facdf58086d498d5bff3cc0bfc4fc347f85\", \"webview_instrumentation_test_apk\": \"b7effc7bf810ed9df9ff89023db208d4fd07395b\", \"wtf_unittests\": \"6e828c57b9facdf01c1f15efe95a655d74854cb0\"}, \"swarm_hashes_refs/heads/master(at){#672134}_without_patch\": {\"android_webview_unittests\": \"8b71f1591f44c1304cf9b8633eb9718170bfc5f0\", \"angle_unittests\": \"7f3320afe99cec3c0092826aa3cf4ae114fcaa69\", \"base_unittests\": \"aa2eed63c0f3d6ee6f889f3b791278e4cf86b64c\", \"base_util_unittests\": \"4f1a94d0f73b7259f2059ec082138f01b44457d6\", \"blink_common_unittests\": \"4ac68252c50c9555d1c056ce86a549b9159d5797\", \"blink_heap_unittests\": \"5a406780ccf4015489412f61681945f2ee433e9b\", \"blink_platform_unittests\": \"a64f5a20151f7629b5728834dd083b0e7952f151\", \"blink_unittests\": \"6f99ef28485c7c386c51ba71334c4a117d30c680\", \"boringssl_crypto_tests\": \"7439a215f6c93077ea267c36ef031370f25989ba\", \"boringssl_ssl_tests\": \"8a5f73528ec512878bbc770a53f5c0236376a3b1\", \"breakpad_unittests\": \"7d4f0dbb2936e6677a50149449124eb51b4c64d6\", \"cacheinvalidation_unittests\": \"99e307a78254811af5cc86d4cd0cd326a91a6ce0\", \"capture_unittests\": \"c9a8c18c6459ac184fbf63972a6153aede1c11ab\", \"cast_unittests\": \"25e08c41c132d16337501361e0fd87544c523e13\", \"cc_unittests\": \"e4d81328fbad8cd8ee66160a44c949a4f7cd5fe1\", \"chrome_public_test_apk\": \"bc5c0713c658a755ec41240db19dde267e8cb63f\", \"chrome_public_test_vr_apk\": \"43d0e23e0245e6905f7cea4e193f5c1001d65cad\", \"components_browsertests\": \"138a338046e6efc7580fb7fcc9ae41f4eda71184\", \"components_unittests\": \"e3b14fb691913c3b77e8e6d91e0b1771a0b44e6b\", \"content_browsertests\": \"ee0c8b90f3984b32bc4410835e0ef4a97ffeeee2\", \"content_shell_test_apk\": \"081f1d1450475af9fa0c79977d58146f2129b8b4\", \"content_unittests\": \"736f1a0aff6b1e8882cc0bad150db3e7bce2ed65\", \"crypto_unittests\": \"4e950a700a52889655ba5b3b0d638084b745b744\", \"device_unittests\": \"0f9a4b663c78135fba32585f32172cd6e1ee6989\", \"display_unittests\": \"b8b99e8f570a616d4d0c4dd338c949ec23653bc5\", \"events_unittests\": \"23fe9226330fcbffa397b7742ea21d573093098e\", \"gcm_unit_tests\": \"4a96b37b166338c829270a11d48f74195839db2c\", \"gfx_unittests\": \"6c5674b1c93f9c4043b6a33747d3316b72172986\", \"gin_unittests\": \"aa5c6b0a6f2fbf6d7dc76de6fecba326fbebd0ee\", \"gl_tests\": \"e79b5f4d0161d65934a8719c2f559ae69ada9f9a\", \"gl_unittests\": \"53b9bb9582d12590d4a0c1e6b3c70dec0790de7c\", \"google_apis_unittests\": \"d7766d00a4ba4ae0c074a8fd275c4fd0351e4bbc\", \"gpu_unittests\": \"fde7be26fddd1c237e680f14ff6ed839242ea221\", \"ipc_tests\": \"b25081cf31a31a1fb95f4a6e3e4facaee7c89573\", \"jingle_unittests\": \"dfa92ab2537ae86a2a6fd0696d68eda3257241bf\", \"latency_unittests\": \"aa2164102a087ba071b0d967a52dd0a4e8cd213e\", \"libjingle_xmpp_unittests\": \"ec32da508e51e2adf3cac8982f962631f2b9523d\", \"media_blink_unittests\": \"709b987fb16f39107ddf473d24293c610853f5bc\", \"media_service_unittests\": \"f4cf66be68159bedc95db9720a8d9fa906d6d50f\", \"media_unittests\": \"8a18386d29724fec75e421e1d7df6317f096b212\", \"midi_unittests\": \"bcb593f30dc750aef1021751bcaeaf96988b21ed\", \"mojo_test_apk\": \"22665697e2dc6c645f514721f5c6c44165d98167\", \"mojo_unittests\": \"ee2897a6f6462e9508468f1292181be5a57ceabc\", \"net_unittests\": \"284e326f3f99cbe517f70b0bb4f5898013e9cbc3\", \"sandbox_linux_unittests\": \"f60cbcbd6537f1fab3a3dd8b0c8528d6e635ba90\", \"services_unittests\": \"16f1aedf16819e0d7c317246099691202f6df88d\", \"shell_dialogs_unittests\": \"c3495cb1903aa8957ddc3315f26d2c7e96741339\", \"skia_unittests\": \"cb880ef4caccdf2c4a62e12267a994ec3447dffb\", \"sql_unittests\": \"06ef5dff3a0e4df923fd3b9493344a0fb7ad429c\", \"storage_unittests\": \"84f56dd31a9d89b5e642b1e1f75126b96f0a49cd\", \"ui_android_unittests\": \"7127e03467c8656009aa67118ecba347cba5e640\", \"ui_base_unittests\": \"823be2d713fd9c3adf3f71be76573d3ce3a5cb1c\", \"ui_touch_selection_unittests\": \"94ae401cdea278a53d20fe88c9978e5c74675f76\", \"unit_tests\": \"ac9a69877ed1d1b651745512533ca629536715c8\", \"url_unittests\": \"402733471a2e0cb891a54ca7590381927b1901a2\", \"viz_unittests\": \"80740f08bf2fa8f4a07f944b4182dcd1684f7e3a\", \"vr_android_unittests\": \"9650232ce2b465bacf082248533d57f1b278e149\", \"vr_common_unittests\": \"a78dd81f99c58d58afcd8db3ce57466d976442dd\", \"vr_pixeltests\": \"d40e8facdf58086d498d5bff3cc0bfc4fc347f85\", \"webview_instrumentation_test_apk\": \"b7effc7bf810ed9df9ff89023db208d4fd07395b\", \"wtf_unittests\": \"6e828c57b9facdf01c1f15efe95a655d74854cb0\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"android-code-coverage\"], \"caches\": [\"builder_f2ac5903ab08ee4ddab389becac92d3a3647f6b791038f1abef5b06a03e08513_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"android-code-coverage-0-9ov0\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-highmem-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4339-6285c57\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 tests failed: ['latency_unittests on Android device Nexus 5X']\"}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1561484201680519",
"status": "COMPLETED",
"status_changed_ts": "1561484202442635",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/1545",
"builder:android-code-coverage",
"buildset:commit/git/8370e6d6637ba8e89a0d32b8bf31bd1cfbe86c12",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8370e6d6637ba8e89a0d32b8bf31bd1cfbe86c12",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075088997459188704",
"scheduler_job_id:chromium/android-code-coverage",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8909658935340874784/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:45a88679a51bea10",
"user_agent:luci-scheduler"
],
"updated_ts": "1561487426626764",
"url": "https://ci.chromium.org/b/8909658935340874784",
"utcnow_ts": "1561487427704540"
}
}
[18:30:27.728] Invocation finished in 55m1.497222584s with status FAILED