[11:28:18.661] New invocation is queued and will start shortly
[11:28:19.763] Starting the invocation (attempt 1)
[11:28:19.819] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:28:19.819] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:28:19.819] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9071216425503462400",
"parameters_json": "{\"builder_name\":\"android-code-coverage\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"1fb6afd000741030841feb85e3d5373fb5f514f0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-code-coverage",
"scheduler_invocation_id:9071216425503462400",
"scheduler_job_id:chromium/android-code-coverage",
"user_agent:luci-scheduler",
"buildset:commit/git/1fb6afd000741030841feb85e3d5373fb5f514f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1fb6afd000741030841feb85e3d5373fb5f514f0",
"gitiles_ref:refs/heads/master"
]
}
[11:28:21.455] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1565177300116905",
"id": "8905786363312168912",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1fb6afd000741030841feb85e3d5373fb5f514f0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565177300664618",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/2401",
"builder:android-code-coverage",
"buildset:commit/git/1fb6afd000741030841feb85e3d5373fb5f514f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1fb6afd000741030841feb85e3d5373fb5f514f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071216425503462400",
"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/8905786363312168912/+/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": "1565177300664722",
"url": "https://ci.chromium.org/b/8905786363312168912",
"utcnow_ts": "1565177301427935"
}
}
[11:28:21.456] Task URL: https://ci.chromium.org/b/8905786363312168912
[11:28:21.456] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:2:0) after 1m0s
[11:29:13.856] Received PubSub notification, asking Buildbucket for the build status
[11:29:13.986] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:21.502] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:2:0)
[11:29:21.502] Timer tick, asking Buildbucket for the build status
[11:29:21.707] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:21.707] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:4:0) after 1m0s
[11:30:21.796] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:4:0)
[11:30:21.796] Timer tick, asking Buildbucket for the build status
[11:30:22.298] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:22.298] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:5:0) after 1m0s
[11:31:22.333] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:5:0)
[11:31:22.333] Timer tick, asking Buildbucket for the build status
[11:31:23.256] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:23.256] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:6:0) after 1m0s
[11:32:23.409] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:6:0)
[11:32:23.409] Timer tick, asking Buildbucket for the build status
[11:32:23.863] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:23.863] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:7:0) after 1m0s
[11:33:23.887] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:7:0)
[11:33:23.887] Timer tick, asking Buildbucket for the build status
[11:33:24.342] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:24.342] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:8:0) after 1m0s
[11:34:24.354] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:8:0)
[11:34:24.354] Timer tick, asking Buildbucket for the build status
[11:34:25.459] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:25.459] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:9:0) after 1m0s
[11:35:25.488] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:9:0)
[11:35:25.488] Timer tick, asking Buildbucket for the build status
[11:35:26.213] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:26.213] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:10:0) after 1m0s
[11:36:26.234] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:10:0)
[11:36:26.234] Timer tick, asking Buildbucket for the build status
[11:36:26.389] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:26.389] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:11:0) after 1m0s
[11:37:26.476] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:11:0)
[11:37:26.476] Timer tick, asking Buildbucket for the build status
[11:37:27.114] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:27.114] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:12:0) after 1m0s
[11:38:27.190] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:12:0)
[11:38:27.190] Timer tick, asking Buildbucket for the build status
[11:38:27.850] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:27.850] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:13:0) after 1m0s
[11:39:27.965] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:13:0)
[11:39:27.965] Timer tick, asking Buildbucket for the build status
[11:39:28.302] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:28.303] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:14:0) after 1m0s
[11:40:28.363] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:14:0)
[11:40:28.363] Timer tick, asking Buildbucket for the build status
[11:40:30.563] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:30.563] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:15:0) after 1m0s
[11:41:30.583] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:15:0)
[11:41:30.583] Timer tick, asking Buildbucket for the build status
[11:41:31.120] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:31.120] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:16:0) after 1m0s
[11:42:31.200] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:16:0)
[11:42:31.200] Timer tick, asking Buildbucket for the build status
[11:42:31.419] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:31.419] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:17:0) after 1m0s
[11:43:31.433] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:17:0)
[11:43:31.433] Timer tick, asking Buildbucket for the build status
[11:43:31.685] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:31.685] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:18:0) after 1m0s
[11:44:31.759] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:18:0)
[11:44:31.759] Timer tick, asking Buildbucket for the build status
[11:44:32.174] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:32.174] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:19:0) after 1m0s
[11:45:32.169] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:19:0)
[11:45:32.169] Timer tick, asking Buildbucket for the build status
[11:45:32.444] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:32.444] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:20:0) after 1m0s
[11:46:32.460] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:20:0)
[11:46:32.460] Timer tick, asking Buildbucket for the build status
[11:46:33.197] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:33.198] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:21:0) after 1m0s
[11:47:33.210] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:21:0)
[11:47:33.210] Timer tick, asking Buildbucket for the build status
[11:47:34.029] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:34.029] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:22:0) after 1m0s
[11:48:34.096] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:22:0)
[11:48:34.096] Timer tick, asking Buildbucket for the build status
[11:48:35.145] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:35.145] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:23:0) after 1m0s
[11:49:35.221] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:23:0)
[11:49:35.221] Timer tick, asking Buildbucket for the build status
[11:49:35.985] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:35.985] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:24:0) after 1m0s
[11:50:36.086] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:24:0)
[11:50:36.087] Timer tick, asking Buildbucket for the build status
[11:50:36.643] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:36.643] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:25:0) after 1m0s
[11:51:36.648] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:25:0)
[11:51:36.648] Timer tick, asking Buildbucket for the build status
[11:51:36.990] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:36.990] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:26:0) after 1m0s
[11:52:37.030] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:26:0)
[11:52:37.030] Timer tick, asking Buildbucket for the build status
[11:52:37.263] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:37.263] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:27:0) after 1m0s
[11:53:37.308] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:27:0)
[11:53:37.308] Timer tick, asking Buildbucket for the build status
[11:53:37.650] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:37.650] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:28:0) after 1m0s
[11:54:37.733] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:28:0)
[11:54:37.733] Timer tick, asking Buildbucket for the build status
[11:54:37.921] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:37.921] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:29:0) after 1m0s
[11:55:37.988] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:29:0)
[11:55:37.988] Timer tick, asking Buildbucket for the build status
[11:55:38.187] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:38.187] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:30:0) after 1m0s
[11:56:38.214] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:30:0)
[11:56:38.214] Timer tick, asking Buildbucket for the build status
[11:56:38.441] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:38.441] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:31:0) after 1m0s
[11:57:38.506] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:31:0)
[11:57:38.506] Timer tick, asking Buildbucket for the build status
[11:57:39.030] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:39.030] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:32:0) after 1m0s
[11:58:39.056] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:32:0)
[11:58:39.056] Timer tick, asking Buildbucket for the build status
[11:58:39.333] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:39.333] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:33:0) after 1m0s
[11:59:39.331] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:33:0)
[11:59:39.331] Timer tick, asking Buildbucket for the build status
[11:59:40.098] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:40.098] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:34:0) after 1m0s
[12:00:40.126] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:34:0)
[12:00:40.126] Timer tick, asking Buildbucket for the build status
[12:00:40.345] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:40.345] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:35:0) after 1m0s
[12:01:40.445] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:35:0)
[12:01:40.445] Timer tick, asking Buildbucket for the build status
[12:01:40.833] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:40.833] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:36:0) after 1m0s
[12:02:40.967] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:36:0)
[12:02:40.967] Timer tick, asking Buildbucket for the build status
[12:02:41.678] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:41.678] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:37:0) after 1m0s
[12:03:41.768] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:37:0)
[12:03:41.768] Timer tick, asking Buildbucket for the build status
[12:03:42.093] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:42.093] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:38:0) after 1m0s
[12:04:42.148] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:38:0)
[12:04:42.148] Timer tick, asking Buildbucket for the build status
[12:04:42.356] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:42.356] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:39:0) after 1m0s
[12:05:42.483] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:39:0)
[12:05:42.483] Timer tick, asking Buildbucket for the build status
[12:05:42.794] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:42.794] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:40:0) after 1m0s
[12:06:42.820] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:40:0)
[12:06:42.820] Timer tick, asking Buildbucket for the build status
[12:06:43.522] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:43.522] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:41:0) after 1m0s
[12:07:43.625] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:41:0)
[12:07:43.625] Timer tick, asking Buildbucket for the build status
[12:07:44.078] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:44.078] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:42:0) after 1m0s
[12:08:44.198] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:42:0)
[12:08:44.198] Timer tick, asking Buildbucket for the build status
[12:08:44.879] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:44.879] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:43:0) after 1m0s
[12:09:44.910] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:43:0)
[12:09:44.910] Timer tick, asking Buildbucket for the build status
[12:09:45.151] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:45.152] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:44:0) after 1m0s
[12:10:45.226] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:44:0)
[12:10:45.226] Timer tick, asking Buildbucket for the build status
[12:10:45.664] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:45.664] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:45:0) after 1m0s
[12:11:45.690] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:45:0)
[12:11:45.690] Timer tick, asking Buildbucket for the build status
[12:11:46.143] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:46.144] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:46:0) after 1m0s
[12:12:46.217] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:46:0)
[12:12:46.217] Timer tick, asking Buildbucket for the build status
[12:12:49.135] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:49.135] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:47:0) after 1m0s
[12:13:49.162] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:47:0)
[12:13:49.162] Timer tick, asking Buildbucket for the build status
[12:13:49.736] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:49.736] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:48:0) after 1m0s
[12:14:49.743] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:48:0)
[12:14:49.743] Timer tick, asking Buildbucket for the build status
[12:14:50.007] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:50.007] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:49:0) after 1m0s
[12:15:50.037] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:49:0)
[12:15:50.037] Timer tick, asking Buildbucket for the build status
[12:15:51.257] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:51.258] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:50:0) after 1m0s
[12:16:51.280] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:50:0)
[12:16:51.280] Timer tick, asking Buildbucket for the build status
[12:16:52.146] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:52.146] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:51:0) after 1m0s
[12:17:52.286] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:51:0)
[12:17:52.286] Timer tick, asking Buildbucket for the build status
[12:17:52.518] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:52.518] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:52:0) after 1m0s
[12:18:52.546] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:52:0)
[12:18:52.546] Timer tick, asking Buildbucket for the build status
[12:18:52.983] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:52.983] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:53:0) after 1m0s
[12:19:53.040] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:53:0)
[12:19:53.040] Timer tick, asking Buildbucket for the build status
[12:19:53.811] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:53.811] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:54:0) after 1m0s
[12:20:53.930] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:54:0)
[12:20:53.930] Timer tick, asking Buildbucket for the build status
[12:20:54.773] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:54.773] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:55:0) after 1m0s
[12:21:54.846] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:55:0)
[12:21:54.846] Timer tick, asking Buildbucket for the build status
[12:21:55.166] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:55.166] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:56:0) after 1m0s
[12:22:55.314] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:56:0)
[12:22:55.314] Timer tick, asking Buildbucket for the build status
[12:22:55.525] Build 8905786363312168912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:55.525] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071216425503462400:57:0) after 1m0s
[12:23:05.845] Received PubSub notification, asking Buildbucket for the build status
[12:23:06.511] Build 8905786363312168912: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:23:06.511] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1565180584922797",
"created_by": "project:chromium",
"created_ts": "1565177300116905",
"failure_reason": "BUILD_FAILURE",
"id": "8905786363312168912",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1fb6afd000741030841feb85e3d5373fb5f514f0\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**chrome_public_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.chrome.browser.metrics.StartupLoadingMetricsTest#testStartWithURLRecorded\\n\\n**network_service_out_of_process_chrome_public_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testMoveButtonsGoneWithOneBookmark\\n\\n- org.chromium.chrome.browser.metrics.StartupLoadingMetricsTest#testStartWithURLRecorded\"}, \"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\": \"luci-chromium-ci-xenial-us-central1-c-600-ssd-hm32-1-mf1b\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-code-coverage\", \"buildnumber\": 2401, \"coverage_gs_bucket\": \"code-coverage-data\", \"coverage_metadata_gs_path\": \"postsubmit/chromium.googlesource.com/chromium/src/1fb6afd000741030841feb85e3d5373fb5f514f0/ci/android-code-coverage/8905786363312168912/java_metadata\", \"got_angle_revision\": \"415bb0cdb057f60f684b3c01731a4f0e93e3630d\", \"got_dawn_revision\": \"6de5baa17b8acb7100094548a57c541d182fb78b\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"1fb6afd000741030841feb85e3d5373fb5f514f0\", \"got_revision_cp\": \"refs/heads/master@{#684707}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"9a7eefa33863b217c694b4ccd1a119118506b442\", \"got_v8_revision_cp\": \"refs/heads/7.8.65@{#1}\", \"got_webrtc_revision\": \"e71edc5e0d5a40c2f9a43e089fe2741fe04dd60e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28783}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"1fb6afd000741030841feb85e3d5373fb5f514f0\", \"swarm_hashes\": {\"android_browsertests\": \"5aa9e88e296fcdd4c3ff9ddea21f2a724e6c61fa\", \"android_webview_unittests\": \"a56580cae461092719dc7ed6d43eba8fd7ffd404\", \"angle_unittests\": \"697a2cbbfce685bad93fc942fef64bb744d001c1\", \"base_unittests\": \"d3cc83cccc4e46ff79a52fe1e35631481b9c3ff2\", \"base_util_unittests\": \"a0c2b13e8e121b5e7da5af9f9e7f4ad11d0f70d5\", \"blink_common_unittests\": \"f9afbe613f542af337e4c3b00e65db359a64b04a\", \"blink_heap_unittests\": \"94bebe5400d292979cff723aa7154d513357be58\", \"blink_platform_unittests\": \"0b03ce3d6b3a132e222a38a63c258d85f94b283d\", \"blink_unittests\": \"917c5db6cc90fb9f20a2b73d8ca1c0d430c4a46e\", \"boringssl_crypto_tests\": \"67f469e1994db64c34ab2b027731b126cedf351c\", \"boringssl_ssl_tests\": \"e87f9ead39cc2c1a4d249033f08bc3f454de3aa6\", \"breakpad_unittests\": \"e65626c6c7c842f0e063608c3f45eee04ebdbe67\", \"cacheinvalidation_unittests\": \"1511eafbb8b47b0796b4c28f876d4770c1f70d0d\", \"capture_unittests\": \"80fb35edc4d5156e14d0c6edce029124729a340c\", \"cast_unittests\": \"a7637455c9c2bbf2fa067525cdfb6a52eb29a09a\", \"cc_unittests\": \"1c0d2584a1158027a531dca6fbabf95f55dc16b1\", \"chrome_public_test_apk\": \"125e276e8c15a9f83ec33bef2b58e86e0432fb3d\", \"chrome_public_test_vr_apk\": \"b79d0a5aa784051b11c098360fc23730858d7c5c\", \"components_browsertests\": \"769009a1b98aff06ef02efc7b086c33870eac90e\", \"components_unittests\": \"d0008e6e5121f73df9550bd24c95553b1aa3649d\", \"content_browsertests\": \"708c3ef4a8a4e62de8ffc8d1d9e9fa256cb665e6\", \"content_shell_test_apk\": \"3a85f192670febcf3c23aa2043f3ba31458c1897\", \"content_unittests\": \"e28e0dbe5165831c3e68ccef4a8c1b1b1f502787\", \"crypto_unittests\": \"9ad086d30187982ef5508039115d794818b7a9c6\", \"device_unittests\": \"777c1a035669dabbbfae6827576eda99f85df74f\", \"display_unittests\": \"12af826298ec7f6f3ca1d998885076b0a85a8600\", \"events_unittests\": \"48d3972dd5d63f6ffc7468cb919ada80031ea189\", \"gcm_unit_tests\": \"ee15485d14b1f888306caa0d37401faacca2ea3f\", \"gfx_unittests\": \"7f33d4665fd12c2072ca136a4cef79c04fdf255d\", \"gin_unittests\": \"c0d0cccadea1996fac5df0b0ca25124aad72918a\", \"gl_tests\": \"b32156bedb0a469596901fedcde7eb9ab83ca5d8\", \"gl_unittests\": \"d2856cea5fd17d35e2c3aebf6e4e7ee4804d4f00\", \"google_apis_unittests\": \"b65df09492192389d8f17dab3c78c8e6e20c1a21\", \"gpu_unittests\": \"baeec162c1c373377e1ea154b5d5cde0938c6ed5\", \"gwp_asan_unittests\": \"4e06dd04472e4e03205ba9ba4b97237a0492eb2b\", \"ipc_tests\": \"f1e661edfac0b1a41a49f6580ed29bd63573e8c0\", \"jingle_unittests\": \"3e63f169203e027f4914ab8a1952ea60f7602987\", \"latency_unittests\": \"f399b702c8f3de2da322923fa8b03a23a1a03da7\", \"libjingle_xmpp_unittests\": \"a42d61f76249085ef8b857d423a618eac9bb3530\", \"media_blink_unittests\": \"c2e1191745f31a6ea1e76f604ec0221e206fe32f\", \"media_service_unittests\": \"f234ceac56da2eca7057816e5ed4b31edd7545ee\", \"media_unittests\": \"7cadaae9bdc30e3105a82867f345955a84af8c26\", \"midi_unittests\": \"a139cde65f3832db7c138791facd69e1e1f06a4d\", \"mojo_test_apk\": \"41fb036600838296501c8211767671ddf1e321cf\", \"mojo_unittests\": \"060edccce28ca8cbdc2333472e86589e5eaa02eb\", \"net_unittests\": \"42f8c6b548f6a3479768643d2e68bfd063e04e13\", \"sandbox_linux_unittests\": \"fed5a7ff29a98b2d9507d37bf240c4a9185fa6f9\", \"services_unittests\": \"ed765d8b4a9d638a71f649cd4b67bc949d62a731\", \"shell_dialogs_unittests\": \"3c0eb082b8a6fb0c30e33ad3fb57a2a2fba1ff19\", \"skia_unittests\": \"3e9775546a9dae86fc1c89bf536c415619b8da35\", \"sql_unittests\": \"1a52629ceaff2aa8203425c92581ea0e1a689c3c\", \"storage_unittests\": \"789b8292f0d6e43aa807b6119a4ecc3560b93082\", \"ui_android_unittests\": \"0a2da03ec865a03a6e88820c3efc597b63ee19a8\", \"ui_base_unittests\": \"248823b7f003464d7044555b29ddf4e323d6d219\", \"ui_touch_selection_unittests\": \"c9b4f93629dbfbfa0ccf9ed6daf3b094f31dcd65\", \"unit_tests\": \"7918f6bf4379e1cad139a92b51d268777ec08c94\", \"url_unittests\": \"cb936b0210a8d39a2abea3c851f58db7941bce03\", \"viz_unittests\": \"7b8219a05f14f1a85f1c02eb8a5a0afc810c6368\", \"vr_android_unittests\": \"2ca256261d8395381b64fc723cd454886ff9f310\", \"vr_common_unittests\": \"d449d04fae73196c02ff9a1e62debd2cb1377bc6\", \"vr_pixeltests\": \"3b689f73ea018fdf8a96f15e90556fac17cc653f\", \"webview_instrumentation_test_apk\": \"6845d9f2523e39827db61aa4e605644e09b79aae\", \"wtf_unittests\": \"ae68906a569d61dc6cf1c6e81e2742dad865ef6b\"}, \"swarm_hashes_refs/heads/master(at){#684707}_without_patch\": {\"android_browsertests\": \"5aa9e88e296fcdd4c3ff9ddea21f2a724e6c61fa\", \"android_webview_unittests\": \"a56580cae461092719dc7ed6d43eba8fd7ffd404\", \"angle_unittests\": \"697a2cbbfce685bad93fc942fef64bb744d001c1\", \"base_unittests\": \"d3cc83cccc4e46ff79a52fe1e35631481b9c3ff2\", \"base_util_unittests\": \"a0c2b13e8e121b5e7da5af9f9e7f4ad11d0f70d5\", \"blink_common_unittests\": \"f9afbe613f542af337e4c3b00e65db359a64b04a\", \"blink_heap_unittests\": \"94bebe5400d292979cff723aa7154d513357be58\", \"blink_platform_unittests\": \"0b03ce3d6b3a132e222a38a63c258d85f94b283d\", \"blink_unittests\": \"917c5db6cc90fb9f20a2b73d8ca1c0d430c4a46e\", \"boringssl_crypto_tests\": \"67f469e1994db64c34ab2b027731b126cedf351c\", \"boringssl_ssl_tests\": \"e87f9ead39cc2c1a4d249033f08bc3f454de3aa6\", \"breakpad_unittests\": \"e65626c6c7c842f0e063608c3f45eee04ebdbe67\", \"cacheinvalidation_unittests\": \"1511eafbb8b47b0796b4c28f876d4770c1f70d0d\", \"capture_unittests\": \"80fb35edc4d5156e14d0c6edce029124729a340c\", \"cast_unittests\": \"a7637455c9c2bbf2fa067525cdfb6a52eb29a09a\", \"cc_unittests\": \"1c0d2584a1158027a531dca6fbabf95f55dc16b1\", \"chrome_public_test_apk\": \"125e276e8c15a9f83ec33bef2b58e86e0432fb3d\", \"chrome_public_test_vr_apk\": \"b79d0a5aa784051b11c098360fc23730858d7c5c\", \"components_browsertests\": \"769009a1b98aff06ef02efc7b086c33870eac90e\", \"components_unittests\": \"d0008e6e5121f73df9550bd24c95553b1aa3649d\", \"content_browsertests\": \"708c3ef4a8a4e62de8ffc8d1d9e9fa256cb665e6\", \"content_shell_test_apk\": \"3a85f192670febcf3c23aa2043f3ba31458c1897\", \"content_unittests\": \"e28e0dbe5165831c3e68ccef4a8c1b1b1f502787\", \"crypto_unittests\": \"9ad086d30187982ef5508039115d794818b7a9c6\", \"device_unittests\": \"777c1a035669dabbbfae6827576eda99f85df74f\", \"display_unittests\": \"12af826298ec7f6f3ca1d998885076b0a85a8600\", \"events_unittests\": \"48d3972dd5d63f6ffc7468cb919ada80031ea189\", \"gcm_unit_tests\": \"ee15485d14b1f888306caa0d37401faacca2ea3f\", \"gfx_unittests\": \"7f33d4665fd12c2072ca136a4cef79c04fdf255d\", \"gin_unittests\": \"c0d0cccadea1996fac5df0b0ca25124aad72918a\", \"gl_tests\": \"b32156bedb0a469596901fedcde7eb9ab83ca5d8\", \"gl_unittests\": \"d2856cea5fd17d35e2c3aebf6e4e7ee4804d4f00\", \"google_apis_unittests\": \"b65df09492192389d8f17dab3c78c8e6e20c1a21\", \"gpu_unittests\": \"baeec162c1c373377e1ea154b5d5cde0938c6ed5\", \"gwp_asan_unittests\": \"4e06dd04472e4e03205ba9ba4b97237a0492eb2b\", \"ipc_tests\": \"f1e661edfac0b1a41a49f6580ed29bd63573e8c0\", \"jingle_unittests\": \"3e63f169203e027f4914ab8a1952ea60f7602987\", \"latency_unittests\": \"f399b702c8f3de2da322923fa8b03a23a1a03da7\", \"libjingle_xmpp_unittests\": \"a42d61f76249085ef8b857d423a618eac9bb3530\", \"media_blink_unittests\": \"c2e1191745f31a6ea1e76f604ec0221e206fe32f\", \"media_service_unittests\": \"f234ceac56da2eca7057816e5ed4b31edd7545ee\", \"media_unittests\": \"7cadaae9bdc30e3105a82867f345955a84af8c26\", \"midi_unittests\": \"a139cde65f3832db7c138791facd69e1e1f06a4d\", \"mojo_test_apk\": \"41fb036600838296501c8211767671ddf1e321cf\", \"mojo_unittests\": \"060edccce28ca8cbdc2333472e86589e5eaa02eb\", \"net_unittests\": \"42f8c6b548f6a3479768643d2e68bfd063e04e13\", \"sandbox_linux_unittests\": \"fed5a7ff29a98b2d9507d37bf240c4a9185fa6f9\", \"services_unittests\": \"ed765d8b4a9d638a71f649cd4b67bc949d62a731\", \"shell_dialogs_unittests\": \"3c0eb082b8a6fb0c30e33ad3fb57a2a2fba1ff19\", \"skia_unittests\": \"3e9775546a9dae86fc1c89bf536c415619b8da35\", \"sql_unittests\": \"1a52629ceaff2aa8203425c92581ea0e1a689c3c\", \"storage_unittests\": \"789b8292f0d6e43aa807b6119a4ecc3560b93082\", \"ui_android_unittests\": \"0a2da03ec865a03a6e88820c3efc597b63ee19a8\", \"ui_base_unittests\": \"248823b7f003464d7044555b29ddf4e323d6d219\", \"ui_touch_selection_unittests\": \"c9b4f93629dbfbfa0ccf9ed6daf3b094f31dcd65\", \"unit_tests\": \"7918f6bf4379e1cad139a92b51d268777ec08c94\", \"url_unittests\": \"cb936b0210a8d39a2abea3c851f58db7941bce03\", \"viz_unittests\": \"7b8219a05f14f1a85f1c02eb8a5a0afc810c6368\", \"vr_android_unittests\": \"2ca256261d8395381b64fc723cd454886ff9f310\", \"vr_common_unittests\": \"d449d04fae73196c02ff9a1e62debd2cb1377bc6\", \"vr_pixeltests\": \"3b689f73ea018fdf8a96f15e90556fac17cc653f\", \"webview_instrumentation_test_apk\": \"6845d9f2523e39827db61aa4e605644e09b79aae\", \"wtf_unittests\": \"ae68906a569d61dc6cf1c6e81e2742dad865ef6b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1cf5addf4d1b07dee05bb817410abedd1ddd14dde2cca1baf3f95933882f5cfd_v2\", \"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\": [\"luci-chromium-ci-xenial-us-central1-c-600-ssd-hm32-1-mf1b\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-highmem-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4382-5929880\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**chrome_public_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.chrome.browser.metrics.StartupLoadingMetricsTest#testStartWithURLRecorded\\n\\n**network_service_out_of_process_chrome_public_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testMoveButtonsGoneWithOneBookmark\\n\\n- org.chromium.chrome.browser.metrics.StartupLoadingMetricsTest#testStartWithURLRecorded\"}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1565177352350903",
"status": "COMPLETED",
"status_changed_ts": "1565177353518043",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/2401",
"builder:android-code-coverage",
"buildset:commit/git/1fb6afd000741030841feb85e3d5373fb5f514f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1fb6afd000741030841feb85e3d5373fb5f514f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071216425503462400",
"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/8905786363312168912/+/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:4684a7d1c88d9c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1565180585273814",
"url": "https://ci.chromium.org/b/8905786363312168912",
"utcnow_ts": "1565180586480337"
}
}
[12:23:06.511] Invocation finished in 54m47.869096356s with status FAILED