[17:29:59.725] New invocation is queued and will start shortly
[17:30:00.853] Starting the invocation (attempt 1)
[17:30:00.915] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:30:00.915] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:30:00.915] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9075542324677160864",
"parameters_json": "{\"builder_name\":\"android-code-coverage\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"596d31871804a96afaf3c71574c771cf975236ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-code-coverage",
"scheduler_invocation_id:9075542324677160864",
"scheduler_job_id:chromium/android-code-coverage",
"user_agent:luci-scheduler",
"buildset:commit/git/596d31871804a96afaf3c71574c771cf975236ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/596d31871804a96afaf3c71574c771cf975236ee",
"gitiles_ref:refs/heads/master"
]
}
[17:30:02.746] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1561051801476542",
"id": "8910112262173344576",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"596d31871804a96afaf3c71574c771cf975236ee\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1561051802572850",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/1397",
"builder:android-code-coverage",
"buildset:commit/git/596d31871804a96afaf3c71574c771cf975236ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/596d31871804a96afaf3c71574c771cf975236ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075542324677160864",
"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/8910112262173344576/+/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": "1561051802572942",
"url": "https://ci.chromium.org/b/8910112262173344576",
"utcnow_ts": "1561051802723521"
}
}
[17:30:02.746] Task URL: https://ci.chromium.org/b/8910112262173344576
[17:30:02.746] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:2:0) after 1m0s
[17:30:41.209] Received PubSub notification, asking Buildbucket for the build status
[17:30:41.922] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:02.814] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:2:0)
[17:31:02.814] Timer tick, asking Buildbucket for the build status
[17:31:03.978] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:03.978] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:4:0) after 1m0s
[17:32:04.005] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:4:0)
[17:32:04.005] Timer tick, asking Buildbucket for the build status
[17:32:06.219] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:06.219] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:5:0) after 1m0s
[17:33:06.242] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:5:0)
[17:33:06.242] Timer tick, asking Buildbucket for the build status
[17:33:06.572] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:06.572] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:6:0) after 1m0s
[17:34:06.593] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:6:0)
[17:34:06.593] Timer tick, asking Buildbucket for the build status
[17:34:06.829] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:06.829] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:7:0) after 1m0s
[17:35:06.860] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:7:0)
[17:35:06.860] Timer tick, asking Buildbucket for the build status
[17:35:07.283] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:07.283] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:8:0) after 1m0s
[17:36:07.363] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:8:0)
[17:36:07.363] Timer tick, asking Buildbucket for the build status
[17:36:09.649] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:09.649] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:9:0) after 1m0s
[17:37:09.696] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:9:0)
[17:37:09.696] Timer tick, asking Buildbucket for the build status
[17:37:16.295] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:16.295] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:10:0) after 1m0s
[17:38:16.317] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:10:0)
[17:38:16.317] Timer tick, asking Buildbucket for the build status
[17:38:17.181] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:17.182] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:11:0) after 1m0s
[17:39:17.196] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:11:0)
[17:39:17.196] Timer tick, asking Buildbucket for the build status
[17:39:18.566] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:18.566] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:12:0) after 1m0s
[17:40:18.586] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:12:0)
[17:40:18.586] Timer tick, asking Buildbucket for the build status
[17:40:18.700] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:18.700] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:13:0) after 1m0s
[17:41:18.736] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:13:0)
[17:41:18.736] Timer tick, asking Buildbucket for the build status
[17:41:18.835] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:18.835] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:14:0) after 1m0s
[17:42:18.892] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:14:0)
[17:42:18.892] Timer tick, asking Buildbucket for the build status
[17:42:19.217] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:19.217] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:15:0) after 1m0s
[17:43:19.236] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:15:0)
[17:43:19.236] Timer tick, asking Buildbucket for the build status
[17:43:20.938] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:20.938] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:16:0) after 1m0s
[17:44:20.962] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:16:0)
[17:44:20.962] Timer tick, asking Buildbucket for the build status
[17:44:21.333] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:21.333] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:17:0) after 1m0s
[17:45:21.381] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:17:0)
[17:45:21.381] Timer tick, asking Buildbucket for the build status
[17:45:21.945] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:21.945] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:18:0) after 1m0s
[17:46:21.977] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:18:0)
[17:46:21.977] Timer tick, asking Buildbucket for the build status
[17:46:22.616] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:22.616] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:19:0) after 1m0s
[17:47:22.687] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:19:0)
[17:47:22.687] Timer tick, asking Buildbucket for the build status
[17:47:23.245] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:23.245] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:20:0) after 1m0s
[17:48:23.266] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:20:0)
[17:48:23.266] Timer tick, asking Buildbucket for the build status
[17:48:23.823] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:23.823] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:21:0) after 1m0s
[17:49:23.856] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:21:0)
[17:49:23.856] Timer tick, asking Buildbucket for the build status
[17:49:24.083] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:24.083] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:22:0) after 1m0s
[17:50:24.156] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:22:0)
[17:50:24.156] Timer tick, asking Buildbucket for the build status
[17:50:26.322] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:26.322] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:23:0) after 1m0s
[17:51:26.468] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:23:0)
[17:51:26.468] Timer tick, asking Buildbucket for the build status
[17:51:27.979] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:27.979] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:24:0) after 1m0s
[17:52:28.080] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:24:0)
[17:52:28.080] Timer tick, asking Buildbucket for the build status
[17:52:28.724] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:28.724] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:25:0) after 1m0s
[17:53:28.763] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:25:0)
[17:53:28.763] Timer tick, asking Buildbucket for the build status
[17:53:28.879] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:28.879] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:26:0) after 1m0s
[17:54:28.903] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:26:0)
[17:54:28.903] Timer tick, asking Buildbucket for the build status
[17:54:29.041] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:29.041] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:27:0) after 1m0s
[17:55:29.084] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:27:0)
[17:55:29.084] Timer tick, asking Buildbucket for the build status
[17:55:30.195] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:30.195] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:28:0) after 1m0s
[17:56:30.216] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:28:0)
[17:56:30.216] Timer tick, asking Buildbucket for the build status
[17:56:30.660] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:30.661] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:29:0) after 1m0s
[17:57:30.753] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:29:0)
[17:57:30.753] Timer tick, asking Buildbucket for the build status
[17:57:30.999] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:30.999] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:30:0) after 1m0s
[17:58:31.085] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:30:0)
[17:58:31.085] Timer tick, asking Buildbucket for the build status
[17:58:31.940] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:31.940] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:31:0) after 1m0s
[17:59:31.977] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:31:0)
[17:59:31.978] Timer tick, asking Buildbucket for the build status
[17:59:32.587] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:32.587] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:32:0) after 1m0s
[18:00:32.604] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:32:0)
[18:00:32.604] Timer tick, asking Buildbucket for the build status
[18:00:35.015] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:35.015] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:33:0) after 1m0s
[18:01:35.059] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:33:0)
[18:01:35.059] Timer tick, asking Buildbucket for the build status
[18:01:35.511] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:35.511] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:34:0) after 1m0s
[18:02:35.789] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:34:0)
[18:02:35.789] Timer tick, asking Buildbucket for the build status
[18:02:36.024] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:36.024] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:35:0) after 1m0s
[18:03:36.147] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:35:0)
[18:03:36.147] Timer tick, asking Buildbucket for the build status
[18:03:36.509] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:36.509] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:36:0) after 1m0s
[18:04:36.612] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:36:0)
[18:04:36.612] Timer tick, asking Buildbucket for the build status
[18:04:38.471] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:38.471] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:37:0) after 1m0s
[18:05:38.610] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:37:0)
[18:05:38.610] Timer tick, asking Buildbucket for the build status
[18:05:39.260] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:39.260] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:38:0) after 1m0s
[18:06:39.367] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:38:0)
[18:06:39.367] Timer tick, asking Buildbucket for the build status
[18:06:39.922] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:39.922] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:39:0) after 1m0s
[18:07:40.249] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:39:0)
[18:07:40.249] Timer tick, asking Buildbucket for the build status
[18:07:41.057] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:41.057] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:40:0) after 1m0s
[18:08:41.113] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:40:0)
[18:08:41.113] Timer tick, asking Buildbucket for the build status
[18:08:41.817] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:41.817] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:41:0) after 1m0s
[18:09:41.859] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:41:0)
[18:09:41.859] Timer tick, asking Buildbucket for the build status
[18:09:42.563] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:42.563] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:42:0) after 1m0s
[18:10:42.585] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:42:0)
[18:10:42.585] Timer tick, asking Buildbucket for the build status
[18:10:43.932] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:43.932] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:43:0) after 1m0s
[18:11:43.975] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:43:0)
[18:11:43.975] Timer tick, asking Buildbucket for the build status
[18:11:46.022] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:46.022] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:44:0) after 1m0s
[18:12:46.054] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:44:0)
[18:12:46.054] Timer tick, asking Buildbucket for the build status
[18:12:46.810] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:46.810] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:45:0) after 1m0s
[18:13:46.816] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:45:0)
[18:13:46.816] Timer tick, asking Buildbucket for the build status
[18:13:47.285] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:47.285] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:46:0) after 1m0s
[18:14:47.418] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:46:0)
[18:14:47.418] Timer tick, asking Buildbucket for the build status
[18:14:49.083] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:49.083] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:47:0) after 1m0s
[18:15:49.109] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:47:0)
[18:15:49.109] Timer tick, asking Buildbucket for the build status
[18:15:49.387] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:49.387] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:48:0) after 1m0s
[18:16:49.458] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:48:0)
[18:16:49.466] Timer tick, asking Buildbucket for the build status
[18:16:50.996] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:50.996] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:49:0) after 1m0s
[18:17:51.076] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:49:0)
[18:17:51.076] Timer tick, asking Buildbucket for the build status
[18:17:51.281] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:51.281] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:50:0) after 1m0s
[18:18:51.268] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:50:0)
[18:18:51.268] Timer tick, asking Buildbucket for the build status
[18:18:51.388] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:51.389] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:51:0) after 1m0s
[18:19:51.431] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:51:0)
[18:19:51.431] Timer tick, asking Buildbucket for the build status
[18:19:51.788] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:51.788] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:52:0) after 1m0s
[18:20:51.792] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:52:0)
[18:20:51.792] Timer tick, asking Buildbucket for the build status
[18:20:52.968] Build 8910112262173344576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:52.968] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9075542324677160864:53:0) after 1m0s
[18:21:16.057] Received PubSub notification, asking Buildbucket for the build status
[18:21:16.193] Build 8910112262173344576: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:21:16.193] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1561054874567431",
"created_by": "project:chromium",
"created_ts": "1561051801476542",
"failure_reason": "BUILD_FAILURE",
"id": "8910112262173344576",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"596d31871804a96afaf3c71574c771cf975236ee\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 tests failed: ['network_service_out_of_process_chrome_public_test_apk 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\": 1397, \"got_angle_revision\": \"3ea463bfa4ed941977fcb25055bddebe2b749a83\", \"got_dawn_revision\": \"92cdeaaf810bee05e4b23e99fc2bededbdfa59d4\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"596d31871804a96afaf3c71574c771cf975236ee\", \"got_revision_cp\": \"refs/heads/master@{#670955}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"1bd055718ebc189f9ef28293898a6e96f7ff86be\", \"got_v8_revision_cp\": \"refs/heads/7.7.121@{#1}\", \"got_webrtc_revision\": \"6924d508a2fb1a43bf0072aad9a27cf2b2875969\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28336}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"596d31871804a96afaf3c71574c771cf975236ee\", \"swarm_hashes\": {\"android_webview_unittests\": \"7118d3ef83ac69dfc94d68c6fef520eaa3c65891\", \"angle_unittests\": \"a3d43bd22843bcd7e0fb14dfdf750fbc9d2d08a7\", \"base_unittests\": \"48f5046ee11c2e51d877d8739a10f58d8673ee1a\", \"base_util_unittests\": \"fe887a75a762ce5817311a713dab8b8ce32197fd\", \"blink_common_unittests\": \"a2e185d982244b3584559288cfa849d064b21c7e\", \"blink_heap_unittests\": \"93710436131f08195c4e08c1f56748b316674e09\", \"blink_platform_unittests\": \"97a0bb420cfabbc28bdcb8bb75cfc4e3b7b080e1\", \"blink_unittests\": \"f3d64809d72a1f1e7556a3837967336f9a62f027\", \"boringssl_crypto_tests\": \"1322be8ca37dc301e434aa80261470f5edb84deb\", \"boringssl_ssl_tests\": \"fd61aeefa9d258938cf7b4fc0caf959024697f4d\", \"breakpad_unittests\": \"3c8921e2ef10402e2269c3843bfc1894dc9f619c\", \"cacheinvalidation_unittests\": \"18b478dc8e57ef3f6add9e58ca1e69a192a46237\", \"capture_unittests\": \"21b6d805d2aeffe31235ab5e3c9279599b2d2e59\", \"cast_unittests\": \"9110ceb7cc15fcc6da6b091496cfd628acc50047\", \"cc_unittests\": \"f26ba04485aeb0149ae076afede5a47556ad31a6\", \"chrome_public_test_apk\": \"5fdb20db7a9b061c6b4deee4de73a441b0b8014a\", \"chrome_public_test_vr_apk\": \"3d2f6a5538e87b0bdd325d8118390122b9717352\", \"components_browsertests\": \"86d44d548fe95c5c924bcb997da3bedad1e4d057\", \"components_unittests\": \"94fc385586408162838aaf08da4a99417a033f81\", \"content_browsertests\": \"4a06a447bdb16f21bc5e30f4bee65dee6a6bc74f\", \"content_shell_test_apk\": \"01fc1e049d89b67c37f269d4ad2f449abfae4288\", \"content_unittests\": \"a24393042d2d29800fc04d8e8b6da8550bac3461\", \"crypto_unittests\": \"3ff18ceacf602ca3affe6547ed95c2593d2163f2\", \"device_unittests\": \"8c813f76643abec59ab4c68a141e02b669b73590\", \"display_unittests\": \"b20fe1f4d995acd359a8b1d8e374b06d89aa3add\", \"events_unittests\": \"ca76b47766c69fd99d7b0b29e7c53e4c15e82925\", \"gcm_unit_tests\": \"3015dd191960b32f0fb99369d5e5d21f0bd2841a\", \"gfx_unittests\": \"3bf0fee4a0ef5d051751393c5c8377c73f625c8b\", \"gin_unittests\": \"caefbf4157943bb48a66e7adb1bcd03d297ccd8d\", \"gl_tests\": \"2f42118e693d826fb0865e45f7f61d4f993e0074\", \"gl_unittests\": \"227db1c8176e0211c74c5b897dd7e8909d5c029b\", \"google_apis_unittests\": \"09cfe3ef903cc0044b8b02c3032ac5a66c40fe64\", \"gpu_unittests\": \"82f67a546f5cbfced1926c64a474db19d923cfc1\", \"ipc_tests\": \"5b7824cb29c030ba33f980649af271b89c7f0c4c\", \"jingle_unittests\": \"a4351616703061a3f687713fafea5b6a476ad78f\", \"latency_unittests\": \"7b13b86e255c5dc1764ad355b083de49e9892e02\", \"libjingle_xmpp_unittests\": \"5abb114a6ce9a2bd8b153575f5c547fff6753254\", \"media_blink_unittests\": \"9e73c85068e4312b4726d1d6f80da7269e9bdf0e\", \"media_service_unittests\": \"06e67145b11177dca75cecc4b86cd676a44442ba\", \"media_unittests\": \"1fee61296f2b81474b83917cb7c069ef18450f09\", \"midi_unittests\": \"53b9e3a35a0d9f86ddfad37ecbf3cdc78510748f\", \"mojo_test_apk\": \"c3e68e2c347a35bc5198765cf4b06250d8a791a6\", \"mojo_unittests\": \"113bef1ecc62187b50cb86260f4e5a55b05a1afa\", \"net_unittests\": \"1e7f1545a0801e6d23f7ce590de05d9bc393497f\", \"sandbox_linux_unittests\": \"aae7da9591f284eed6b734596a5d52c53794a7b0\", \"services_unittests\": \"52ecdc6c33e01f713fe36f65146ee2a173f48f04\", \"shell_dialogs_unittests\": \"a5057a81328494c9a955f861f8300a10f2e0de2b\", \"skia_unittests\": \"f203937a9f46bb62e025c029b3f192403f74a4e2\", \"sql_unittests\": \"554975d3e9c18d69855c047d33fd0d3f0b1aeaae\", \"storage_unittests\": \"c26ee775b73926bd7096aeca7dcde0966fb81e65\", \"ui_android_unittests\": \"1048a51de26b4edba30c8c8626a853d399e3d16c\", \"ui_base_unittests\": \"e9590c8cdb7b76c06fcf8c69a604b5dd08c95c3c\", \"ui_touch_selection_unittests\": \"58418854c46e7adec01f9353d7f06f749f70b978\", \"unit_tests\": \"ac3fe86131ad17b11187cae34d06bd03af876e48\", \"url_unittests\": \"ce1381de043d04ec9b9c53678bbf2957adce342a\", \"viz_unittests\": \"97293adfac986e0ef408e936f03989d13c4ca390\", \"vr_android_unittests\": \"068b759acc8e28771ee28f0cb9c72b60db02240c\", \"vr_common_unittests\": \"e28dc0dccbbb6e4d8bd085e25b64333e0ffaba97\", \"vr_pixeltests\": \"cf03f66b533780ef221110c8b71545d6bd48f9c6\", \"webview_instrumentation_test_apk\": \"a21635409076b4b5773a8fa0934afc77492898ca\", \"wtf_unittests\": \"0d6836ea3150b712422e3a1005d1e4df5289e1c4\"}, \"swarm_hashes_refs/heads/master(at){#670955}_without_patch\": {\"android_webview_unittests\": \"7118d3ef83ac69dfc94d68c6fef520eaa3c65891\", \"angle_unittests\": \"a3d43bd22843bcd7e0fb14dfdf750fbc9d2d08a7\", \"base_unittests\": \"48f5046ee11c2e51d877d8739a10f58d8673ee1a\", \"base_util_unittests\": \"fe887a75a762ce5817311a713dab8b8ce32197fd\", \"blink_common_unittests\": \"a2e185d982244b3584559288cfa849d064b21c7e\", \"blink_heap_unittests\": \"93710436131f08195c4e08c1f56748b316674e09\", \"blink_platform_unittests\": \"97a0bb420cfabbc28bdcb8bb75cfc4e3b7b080e1\", \"blink_unittests\": \"f3d64809d72a1f1e7556a3837967336f9a62f027\", \"boringssl_crypto_tests\": \"1322be8ca37dc301e434aa80261470f5edb84deb\", \"boringssl_ssl_tests\": \"fd61aeefa9d258938cf7b4fc0caf959024697f4d\", \"breakpad_unittests\": \"3c8921e2ef10402e2269c3843bfc1894dc9f619c\", \"cacheinvalidation_unittests\": \"18b478dc8e57ef3f6add9e58ca1e69a192a46237\", \"capture_unittests\": \"21b6d805d2aeffe31235ab5e3c9279599b2d2e59\", \"cast_unittests\": \"9110ceb7cc15fcc6da6b091496cfd628acc50047\", \"cc_unittests\": \"f26ba04485aeb0149ae076afede5a47556ad31a6\", \"chrome_public_test_apk\": \"5fdb20db7a9b061c6b4deee4de73a441b0b8014a\", \"chrome_public_test_vr_apk\": \"3d2f6a5538e87b0bdd325d8118390122b9717352\", \"components_browsertests\": \"86d44d548fe95c5c924bcb997da3bedad1e4d057\", \"components_unittests\": \"94fc385586408162838aaf08da4a99417a033f81\", \"content_browsertests\": \"4a06a447bdb16f21bc5e30f4bee65dee6a6bc74f\", \"content_shell_test_apk\": \"01fc1e049d89b67c37f269d4ad2f449abfae4288\", \"content_unittests\": \"a24393042d2d29800fc04d8e8b6da8550bac3461\", \"crypto_unittests\": \"3ff18ceacf602ca3affe6547ed95c2593d2163f2\", \"device_unittests\": \"8c813f76643abec59ab4c68a141e02b669b73590\", \"display_unittests\": \"b20fe1f4d995acd359a8b1d8e374b06d89aa3add\", \"events_unittests\": \"ca76b47766c69fd99d7b0b29e7c53e4c15e82925\", \"gcm_unit_tests\": \"3015dd191960b32f0fb99369d5e5d21f0bd2841a\", \"gfx_unittests\": \"3bf0fee4a0ef5d051751393c5c8377c73f625c8b\", \"gin_unittests\": \"caefbf4157943bb48a66e7adb1bcd03d297ccd8d\", \"gl_tests\": \"2f42118e693d826fb0865e45f7f61d4f993e0074\", \"gl_unittests\": \"227db1c8176e0211c74c5b897dd7e8909d5c029b\", \"google_apis_unittests\": \"09cfe3ef903cc0044b8b02c3032ac5a66c40fe64\", \"gpu_unittests\": \"82f67a546f5cbfced1926c64a474db19d923cfc1\", \"ipc_tests\": \"5b7824cb29c030ba33f980649af271b89c7f0c4c\", \"jingle_unittests\": \"a4351616703061a3f687713fafea5b6a476ad78f\", \"latency_unittests\": \"7b13b86e255c5dc1764ad355b083de49e9892e02\", \"libjingle_xmpp_unittests\": \"5abb114a6ce9a2bd8b153575f5c547fff6753254\", \"media_blink_unittests\": \"9e73c85068e4312b4726d1d6f80da7269e9bdf0e\", \"media_service_unittests\": \"06e67145b11177dca75cecc4b86cd676a44442ba\", \"media_unittests\": \"1fee61296f2b81474b83917cb7c069ef18450f09\", \"midi_unittests\": \"53b9e3a35a0d9f86ddfad37ecbf3cdc78510748f\", \"mojo_test_apk\": \"c3e68e2c347a35bc5198765cf4b06250d8a791a6\", \"mojo_unittests\": \"113bef1ecc62187b50cb86260f4e5a55b05a1afa\", \"net_unittests\": \"1e7f1545a0801e6d23f7ce590de05d9bc393497f\", \"sandbox_linux_unittests\": \"aae7da9591f284eed6b734596a5d52c53794a7b0\", \"services_unittests\": \"52ecdc6c33e01f713fe36f65146ee2a173f48f04\", \"shell_dialogs_unittests\": \"a5057a81328494c9a955f861f8300a10f2e0de2b\", \"skia_unittests\": \"f203937a9f46bb62e025c029b3f192403f74a4e2\", \"sql_unittests\": \"554975d3e9c18d69855c047d33fd0d3f0b1aeaae\", \"storage_unittests\": \"c26ee775b73926bd7096aeca7dcde0966fb81e65\", \"ui_android_unittests\": \"1048a51de26b4edba30c8c8626a853d399e3d16c\", \"ui_base_unittests\": \"e9590c8cdb7b76c06fcf8c69a604b5dd08c95c3c\", \"ui_touch_selection_unittests\": \"58418854c46e7adec01f9353d7f06f749f70b978\", \"unit_tests\": \"ac3fe86131ad17b11187cae34d06bd03af876e48\", \"url_unittests\": \"ce1381de043d04ec9b9c53678bbf2957adce342a\", \"viz_unittests\": \"97293adfac986e0ef408e936f03989d13c4ca390\", \"vr_android_unittests\": \"068b759acc8e28771ee28f0cb9c72b60db02240c\", \"vr_common_unittests\": \"e28dc0dccbbb6e4d8bd085e25b64333e0ffaba97\", \"vr_pixeltests\": \"cf03f66b533780ef221110c8b71545d6bd48f9c6\", \"webview_instrumentation_test_apk\": \"a21635409076b4b5773a8fa0934afc77492898ca\", \"wtf_unittests\": \"0d6836ea3150b712422e3a1005d1e4df5289e1c4\"}}, \"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: ['network_service_out_of_process_chrome_public_test_apk on Android device Nexus 5X']\"}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1561051840625418",
"status": "COMPLETED",
"status_changed_ts": "1561051840929471",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/1397",
"builder:android-code-coverage",
"buildset:commit/git/596d31871804a96afaf3c71574c771cf975236ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/596d31871804a96afaf3c71574c771cf975236ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075542324677160864",
"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/8910112262173344576/+/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:458ec1b711957410",
"user_agent:luci-scheduler"
],
"updated_ts": "1561054875507912",
"url": "https://ci.chromium.org/b/8910112262173344576",
"utcnow_ts": "1561054876184060"
}
}
[18:21:16.193] Invocation finished in 51m16.488164261s with status FAILED