[02:23:34.275] New invocation is queued and will start shortly
[02:23:35.466] Starting the invocation (attempt 1)
[02:23:35.543] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:23:35.543] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:23:35.543] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9072519055097406576",
"parameters_json": "{\"builder_name\":\"android-code-coverage\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"42a20608bc0658c89c368ccae584525359e3c084\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-code-coverage",
"scheduler_invocation_id:9072519055097406576",
"scheduler_job_id:chromium/android-code-coverage",
"user_agent:luci-scheduler",
"buildset:commit/git/42a20608bc0658c89c368ccae584525359e3c084",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42a20608bc0658c89c368ccae584525359e3c084",
"gitiles_ref:refs/heads/master"
]
}
[02:23:36.249] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563935015722877",
"id": "8907088992912141568",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"42a20608bc0658c89c368ccae584525359e3c084\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563935016124336",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/2100",
"builder:android-code-coverage",
"buildset:commit/git/42a20608bc0658c89c368ccae584525359e3c084",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42a20608bc0658c89c368ccae584525359e3c084",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072519055097406576",
"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/8907088992912141568/+/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": "1563935016124430",
"url": "https://ci.chromium.org/b/8907088992912141568",
"utcnow_ts": "1563935016240114"
}
}
[02:23:36.249] Task URL: https://ci.chromium.org/b/8907088992912141568
[02:23:36.249] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:2:0) after 1m0s
[02:23:39.382] Received PubSub notification, asking Buildbucket for the build status
[02:23:39.765] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:36.283] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:2:0)
[02:24:36.283] Timer tick, asking Buildbucket for the build status
[02:24:36.449] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:36.449] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:4:0) after 1m0s
[02:25:36.502] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:4:0)
[02:25:36.502] Timer tick, asking Buildbucket for the build status
[02:25:36.732] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:36.732] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:5:0) after 1m0s
[02:26:36.833] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:5:0)
[02:26:36.833] Timer tick, asking Buildbucket for the build status
[02:26:37.026] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:37.026] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:6:0) after 1m0s
[02:27:37.092] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:6:0)
[02:27:37.092] Timer tick, asking Buildbucket for the build status
[02:27:37.667] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:37.667] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:7:0) after 1m0s
[02:28:37.690] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:7:0)
[02:28:37.690] Timer tick, asking Buildbucket for the build status
[02:28:37.896] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:37.896] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:8:0) after 1m0s
[02:29:37.919] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:8:0)
[02:29:37.919] Timer tick, asking Buildbucket for the build status
[02:29:38.105] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:38.105] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:9:0) after 1m0s
[02:30:38.109] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:9:0)
[02:30:38.109] Timer tick, asking Buildbucket for the build status
[02:30:38.276] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:38.276] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:10:0) after 1m0s
[02:31:38.350] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:10:0)
[02:31:38.350] Timer tick, asking Buildbucket for the build status
[02:31:38.528] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:38.528] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:11:0) after 1m0s
[02:32:38.670] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:11:0)
[02:32:38.670] Timer tick, asking Buildbucket for the build status
[02:32:39.100] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:39.100] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:12:0) after 1m0s
[02:33:39.173] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:12:0)
[02:33:39.173] Timer tick, asking Buildbucket for the build status
[02:33:39.426] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:39.426] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:13:0) after 1m0s
[02:34:39.566] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:13:0)
[02:34:39.566] Timer tick, asking Buildbucket for the build status
[02:34:39.756] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:39.756] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:14:0) after 1m0s
[02:35:39.846] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:14:0)
[02:35:39.846] Timer tick, asking Buildbucket for the build status
[02:35:40.219] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:40.219] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:15:0) after 1m0s
[02:36:40.283] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:15:0)
[02:36:40.283] Timer tick, asking Buildbucket for the build status
[02:36:40.710] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:40.710] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:16:0) after 1m0s
[02:37:40.763] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:16:0)
[02:37:40.763] Timer tick, asking Buildbucket for the build status
[02:37:41.072] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:41.072] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:17:0) after 1m0s
[02:38:41.143] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:17:0)
[02:38:41.143] Timer tick, asking Buildbucket for the build status
[02:38:41.316] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:41.316] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:18:0) after 1m0s
[02:39:41.420] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:18:0)
[02:39:41.420] Timer tick, asking Buildbucket for the build status
[02:39:41.711] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:41.711] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:19:0) after 1m0s
[02:40:41.770] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:19:0)
[02:40:41.770] Timer tick, asking Buildbucket for the build status
[02:40:41.928] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:41.928] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:20:0) after 1m0s
[02:41:42.160] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:20:0)
[02:41:42.160] Timer tick, asking Buildbucket for the build status
[02:41:42.271] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:42.271] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:21:0) after 1m0s
[02:42:42.352] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:21:0)
[02:42:42.352] Timer tick, asking Buildbucket for the build status
[02:42:42.538] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:42.538] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:22:0) after 1m0s
[02:43:42.829] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:22:0)
[02:43:42.829] Timer tick, asking Buildbucket for the build status
[02:43:42.989] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:42.989] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:23:0) after 1m0s
[02:44:43.167] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:23:0)
[02:44:43.167] Timer tick, asking Buildbucket for the build status
[02:44:43.935] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:43.935] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:24:0) after 1m0s
[02:45:44.015] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:24:0)
[02:45:44.015] Timer tick, asking Buildbucket for the build status
[02:45:44.206] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:44.206] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:25:0) after 1m0s
[02:46:44.254] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:25:0)
[02:46:44.254] Timer tick, asking Buildbucket for the build status
[02:46:44.745] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:44.745] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:26:0) after 1m0s
[02:47:44.827] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:26:0)
[02:47:44.827] Timer tick, asking Buildbucket for the build status
[02:47:45.617] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:45.617] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:27:0) after 1m0s
[02:48:45.615] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:27:0)
[02:48:45.615] Timer tick, asking Buildbucket for the build status
[02:48:45.826] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:45.826] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:28:0) after 1m0s
[02:49:45.946] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:28:0)
[02:49:45.946] Timer tick, asking Buildbucket for the build status
[02:49:46.154] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:46.154] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:29:0) after 1m0s
[02:50:46.218] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:29:0)
[02:50:46.218] Timer tick, asking Buildbucket for the build status
[02:50:46.405] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:46.405] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:30:0) after 1m0s
[02:51:46.431] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:30:0)
[02:51:46.431] Timer tick, asking Buildbucket for the build status
[02:51:47.007] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:47.007] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:31:0) after 1m0s
[02:52:47.065] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:31:0)
[02:52:47.065] Timer tick, asking Buildbucket for the build status
[02:52:47.332] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:47.332] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:32:0) after 1m0s
[02:53:47.414] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:32:0)
[02:53:47.414] Timer tick, asking Buildbucket for the build status
[02:53:47.862] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:47.862] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:33:0) after 1m0s
[02:54:47.938] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:33:0)
[02:54:47.938] Timer tick, asking Buildbucket for the build status
[02:54:48.100] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:48.100] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:34:0) after 1m0s
[02:55:48.241] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:34:0)
[02:55:48.241] Timer tick, asking Buildbucket for the build status
[02:55:48.838] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:48.838] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:35:0) after 1m0s
[02:56:48.892] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:35:0)
[02:56:48.892] Timer tick, asking Buildbucket for the build status
[02:56:49.423] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:49.423] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:36:0) after 1m0s
[02:57:49.574] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:36:0)
[02:57:49.574] Timer tick, asking Buildbucket for the build status
[02:57:49.793] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:49.793] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:37:0) after 1m0s
[02:58:49.992] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:37:0)
[02:58:49.992] Timer tick, asking Buildbucket for the build status
[02:58:50.229] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:50.229] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:38:0) after 1m0s
[02:59:50.252] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:38:0)
[02:59:50.252] Timer tick, asking Buildbucket for the build status
[02:59:50.529] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:50.529] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:39:0) after 1m0s
[03:00:50.605] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:39:0)
[03:00:50.605] Timer tick, asking Buildbucket for the build status
[03:00:54.047] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:54.047] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:40:0) after 1m0s
[03:01:54.046] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:40:0)
[03:01:54.046] Timer tick, asking Buildbucket for the build status
[03:01:54.906] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:54.906] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:41:0) after 1m0s
[03:02:54.939] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:41:0)
[03:02:54.939] Timer tick, asking Buildbucket for the build status
[03:02:55.124] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:55.124] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:42:0) after 1m0s
[03:03:55.154] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:42:0)
[03:03:55.154] Timer tick, asking Buildbucket for the build status
[03:03:55.695] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:55.695] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:43:0) after 1m0s
[03:04:55.718] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:43:0)
[03:04:55.718] Timer tick, asking Buildbucket for the build status
[03:04:56.368] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:56.368] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:44:0) after 1m0s
[03:05:56.468] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:44:0)
[03:05:56.468] Timer tick, asking Buildbucket for the build status
[03:05:56.721] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:56.721] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:45:0) after 1m0s
[03:06:56.776] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:45:0)
[03:06:56.776] Timer tick, asking Buildbucket for the build status
[03:06:56.959] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:56.959] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:46:0) after 1m0s
[03:07:57.055] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:46:0)
[03:07:57.055] Timer tick, asking Buildbucket for the build status
[03:07:57.943] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:57.943] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:47:0) after 1m0s
[03:08:57.966] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:47:0)
[03:08:57.966] Timer tick, asking Buildbucket for the build status
[03:08:58.950] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:58.950] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:48:0) after 1m0s
[03:09:58.974] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:48:0)
[03:09:58.974] Timer tick, asking Buildbucket for the build status
[03:09:59.342] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:59.342] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:49:0) after 1m0s
[03:10:59.382] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:49:0)
[03:10:59.382] Timer tick, asking Buildbucket for the build status
[03:10:59.980] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:59.980] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:50:0) after 1m0s
[03:12:00.035] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:50:0)
[03:12:00.035] Timer tick, asking Buildbucket for the build status
[03:12:00.558] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:00.558] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:51:0) after 1m0s
[03:13:00.615] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:51:0)
[03:13:00.615] Timer tick, asking Buildbucket for the build status
[03:13:00.819] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:00.819] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:52:0) after 1m0s
[03:14:00.874] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:52:0)
[03:14:00.874] Timer tick, asking Buildbucket for the build status
[03:14:01.056] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:01.056] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:53:0) after 1m0s
[03:15:01.195] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:53:0)
[03:15:01.195] Timer tick, asking Buildbucket for the build status
[03:15:01.399] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:01.399] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:54:0) after 1m0s
[03:16:01.527] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:54:0)
[03:16:01.527] Timer tick, asking Buildbucket for the build status
[03:16:02.017] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:02.017] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:55:0) after 1m0s
[03:17:02.043] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:55:0)
[03:17:02.043] Timer tick, asking Buildbucket for the build status
[03:17:02.321] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:02.321] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:56:0) after 1m0s
[03:18:02.356] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:56:0)
[03:18:02.356] Timer tick, asking Buildbucket for the build status
[03:18:02.561] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:02.561] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:57:0) after 1m0s
[03:19:02.627] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:57:0)
[03:19:02.628] Timer tick, asking Buildbucket for the build status
[03:19:02.760] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:02.760] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:58:0) after 1m0s
[03:20:02.790] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:58:0)
[03:20:02.790] Timer tick, asking Buildbucket for the build status
[03:20:03.063] Build 8907088992912141568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:03.063] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072519055097406576:59:0) after 1m0s
[03:20:59.205] Received PubSub notification, asking Buildbucket for the build status
[03:21:00.019] Build 8907088992912141568: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:21:00.019] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563938458544733",
"created_by": "project:chromium",
"created_ts": "1563935015722877",
"failure_reason": "BUILD_FAILURE",
"id": "8907088992912141568",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"42a20608bc0658c89c368ccae584525359e3c084\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\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#testCannotSelectPromo\\n\\n**chrome_public_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testSmallDrag_Down_MixedFoldersAndBookmarks\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testSmallDrag_Up_BookmarksOnly\"}, \"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-3-cp80\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-code-coverage\", \"buildnumber\": 2100, \"coverage_gs_bucket\": \"code-coverage-data\", \"coverage_metadata_gs_path\": \"postsubmit/chromium.googlesource.com/chromium/src/42a20608bc0658c89c368ccae584525359e3c084/ci/android-code-coverage/8907088992912141568/java_metadata\", \"got_angle_revision\": \"8bb46c5b9ffc89e3d5eeddcd990fd69bb4cbeecd\", \"got_dawn_revision\": \"8944f0205b04fa5fe396e6f5e4c9298370f96acb\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"42a20608bc0658c89c368ccae584525359e3c084\", \"got_revision_cp\": \"refs/heads/master@{#680296}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"4035531228d69a8e3ec475ef75b51db302e70473\", \"got_v8_revision_cp\": \"refs/heads/7.7.299@{#1}\", \"got_webrtc_revision\": \"cfefa0aef329aac0206c5e56efd90b3b0bdb88b6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28646}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"42a20608bc0658c89c368ccae584525359e3c084\", \"swarm_hashes\": {\"android_browsertests\": \"864f3711874b11a7a09929ae1c6f84de10b3ef5d\", \"android_webview_unittests\": \"c58d54e2c746740d5ea0fd9bd7494d0bda83e5de\", \"angle_unittests\": \"6fd5c5296608da691299573c4b0dfb22e8b56ce4\", \"base_unittests\": \"fe3144d6c42b8c60db60ba4e879ff106db6bd2c0\", \"base_util_unittests\": \"b7419318971aaa06ac4eccccbec56825ee35e3c8\", \"blink_common_unittests\": \"45973767cce8f836cf45cc4b86329a25b29bc5a1\", \"blink_heap_unittests\": \"e16b8a6801dadb18e78b595f50fd0bb68a8d9adc\", \"blink_platform_unittests\": \"9555fc117323560a7a2fe16b6acd99131e2e34dc\", \"blink_unittests\": \"5092795cb502c0faa4fc4624f325aa298baf588d\", \"boringssl_crypto_tests\": \"22f6eec16e7f2da6dfba513f3357b2b6863242c8\", \"boringssl_ssl_tests\": \"b070298635f5b64a598fdd4f712310ca4f1043fc\", \"breakpad_unittests\": \"792470df86098e2632ca01d1075d5ad9fdddd83a\", \"cacheinvalidation_unittests\": \"90cd682c9c9efb29df05663f6b08dea20239c143\", \"capture_unittests\": \"d82047a188ce39fc9c848e0bf3da43e3b911740f\", \"cast_unittests\": \"e87cf68500fd47f54de58336d561c68e9a7917e1\", \"cc_unittests\": \"2f7f61e4f062484e0a3900c7338aaecc29c60747\", \"chrome_public_test_apk\": \"f8b39d61e5de771a002ecb92947e2dbac760bdef\", \"chrome_public_test_vr_apk\": \"50f64de7296ac52183dfb638969de112aa51099e\", \"components_browsertests\": \"51113837b50e3245fce49984abf31e9fb99dc7d0\", \"components_unittests\": \"a1444b4a625c9dde55ca45e80bae2e36cfa58611\", \"content_browsertests\": \"4853ebdb916d9288d888f7d9b0d92f0ed6e04726\", \"content_shell_test_apk\": \"823ef3a7c7a05417ca588e6cbc0e4e24823baa99\", \"content_unittests\": \"7957ac946a2855885d3825fc568a7a25c4dc144f\", \"crypto_unittests\": \"64ee4b48e32ae84f46ea7d355e952b74ce83803b\", \"device_unittests\": \"50abd1b01c209470a656a3278b040e91e2675523\", \"display_unittests\": \"66522ff44282f1c8f0be98a79e86b85bebbf309f\", \"events_unittests\": \"3b6083b2d6f9f3b0d315f63fb8a6c10504355f40\", \"gcm_unit_tests\": \"aa2c1289631f2b4a9f9e241dbadb96074e8c21d9\", \"gfx_unittests\": \"2a476d0b9b7fb491774144ab7884e17d74f8a615\", \"gin_unittests\": \"1170c8336b918bf3312131bd7ffe726a4adec6b5\", \"gl_tests\": \"be4a615a7d0ea05bf83717298c4e6755e28b7a2e\", \"gl_unittests\": \"f925c93c987b61f4dea60fc1039023deb06a937b\", \"google_apis_unittests\": \"2683b8dd756a47710f310175fa6d12f9db06da5d\", \"gpu_unittests\": \"ccb337282c9cf006f32a04c3579599980d38fa3e\", \"ipc_tests\": \"859edccb5f01513f43166d36b26b164276168ba0\", \"jingle_unittests\": \"15ff152d0fc7f0bb203c9a5dae3200b36529f5d2\", \"latency_unittests\": \"0aa3b3ad262567ef957dfcda23c699f3f9ef2465\", \"libjingle_xmpp_unittests\": \"dc111ed2cd4f3557840b981ede648b671ed6042f\", \"media_blink_unittests\": \"9fd35b38a45c6dba9de3ccfc1b2aca1b959e7876\", \"media_service_unittests\": \"dcd73a11ae3c879b4928caa3c4814ac6ecbb2ed7\", \"media_unittests\": \"9d9fa60a5028767453478fa10dcdc2c40ac204a0\", \"midi_unittests\": \"e0402800ad9d96af7e77e171bafcea4031936277\", \"mojo_test_apk\": \"a809f9479c7b1b06bd05426871869eb308427dcb\", \"mojo_unittests\": \"331ad60936e307f299ec8c5f2693d0ac72d3baba\", \"net_unittests\": \"41d55de7f44c61896869f134a4698fb3175a46af\", \"sandbox_linux_unittests\": \"7c885d7f4d51f8c275a313503ded6433edb11ed2\", \"services_unittests\": \"5a4a54125fe96e489f0bcca039b1ce3058361192\", \"shell_dialogs_unittests\": \"845d9ab555abb36658df636105858e02c53850dd\", \"skia_unittests\": \"46746e8953a92ed007c034aebcbb842858ccddf8\", \"sql_unittests\": \"3f91495e033c4360d3fe7fab5329a03d5d44839c\", \"storage_unittests\": \"ea3bc17bbad8fffd61e93f8bbebf9cb06700c24e\", \"ui_android_unittests\": \"1f4a4489da8d7b3601c2ca19054c10e5a2420494\", \"ui_base_unittests\": \"34f3de3261a18442b1a9e36ed38da509b8e7d0d4\", \"ui_touch_selection_unittests\": \"a13fa54febcbf07b2cca134df64dd8c600d4fcba\", \"unit_tests\": \"decbd52da3eb3c0a73f2874d04cf2d26c6bbae5e\", \"url_unittests\": \"bddc2732a8c3c66fe4363cbe2b27b876d4e1f914\", \"viz_unittests\": \"dd994a79e081a0ce9607d654fcd859b5851855a8\", \"vr_android_unittests\": \"fa8ea72a69526ae665bd75399086da11d8a74568\", \"vr_common_unittests\": \"dc884e4b016d2bcf3c125947c54a16e4e7df2b95\", \"vr_pixeltests\": \"57440de1bde42f276aa736035e7632342edcb4b8\", \"webview_instrumentation_test_apk\": \"9fc00bc4000aaecbc5f38cf2685bda6950e273ff\", \"wtf_unittests\": \"982300b603afcefd7a4bb2e69c6c05bd080332f0\"}, \"swarm_hashes_refs/heads/master(at){#680296}_without_patch\": {\"android_browsertests\": \"864f3711874b11a7a09929ae1c6f84de10b3ef5d\", \"android_webview_unittests\": \"c58d54e2c746740d5ea0fd9bd7494d0bda83e5de\", \"angle_unittests\": \"6fd5c5296608da691299573c4b0dfb22e8b56ce4\", \"base_unittests\": \"fe3144d6c42b8c60db60ba4e879ff106db6bd2c0\", \"base_util_unittests\": \"b7419318971aaa06ac4eccccbec56825ee35e3c8\", \"blink_common_unittests\": \"45973767cce8f836cf45cc4b86329a25b29bc5a1\", \"blink_heap_unittests\": \"e16b8a6801dadb18e78b595f50fd0bb68a8d9adc\", \"blink_platform_unittests\": \"9555fc117323560a7a2fe16b6acd99131e2e34dc\", \"blink_unittests\": \"5092795cb502c0faa4fc4624f325aa298baf588d\", \"boringssl_crypto_tests\": \"22f6eec16e7f2da6dfba513f3357b2b6863242c8\", \"boringssl_ssl_tests\": \"b070298635f5b64a598fdd4f712310ca4f1043fc\", \"breakpad_unittests\": \"792470df86098e2632ca01d1075d5ad9fdddd83a\", \"cacheinvalidation_unittests\": \"90cd682c9c9efb29df05663f6b08dea20239c143\", \"capture_unittests\": \"d82047a188ce39fc9c848e0bf3da43e3b911740f\", \"cast_unittests\": \"e87cf68500fd47f54de58336d561c68e9a7917e1\", \"cc_unittests\": \"2f7f61e4f062484e0a3900c7338aaecc29c60747\", \"chrome_public_test_apk\": \"f8b39d61e5de771a002ecb92947e2dbac760bdef\", \"chrome_public_test_vr_apk\": \"50f64de7296ac52183dfb638969de112aa51099e\", \"components_browsertests\": \"51113837b50e3245fce49984abf31e9fb99dc7d0\", \"components_unittests\": \"a1444b4a625c9dde55ca45e80bae2e36cfa58611\", \"content_browsertests\": \"4853ebdb916d9288d888f7d9b0d92f0ed6e04726\", \"content_shell_test_apk\": \"823ef3a7c7a05417ca588e6cbc0e4e24823baa99\", \"content_unittests\": \"7957ac946a2855885d3825fc568a7a25c4dc144f\", \"crypto_unittests\": \"64ee4b48e32ae84f46ea7d355e952b74ce83803b\", \"device_unittests\": \"50abd1b01c209470a656a3278b040e91e2675523\", \"display_unittests\": \"66522ff44282f1c8f0be98a79e86b85bebbf309f\", \"events_unittests\": \"3b6083b2d6f9f3b0d315f63fb8a6c10504355f40\", \"gcm_unit_tests\": \"aa2c1289631f2b4a9f9e241dbadb96074e8c21d9\", \"gfx_unittests\": \"2a476d0b9b7fb491774144ab7884e17d74f8a615\", \"gin_unittests\": \"1170c8336b918bf3312131bd7ffe726a4adec6b5\", \"gl_tests\": \"be4a615a7d0ea05bf83717298c4e6755e28b7a2e\", \"gl_unittests\": \"f925c93c987b61f4dea60fc1039023deb06a937b\", \"google_apis_unittests\": \"2683b8dd756a47710f310175fa6d12f9db06da5d\", \"gpu_unittests\": \"ccb337282c9cf006f32a04c3579599980d38fa3e\", \"ipc_tests\": \"859edccb5f01513f43166d36b26b164276168ba0\", \"jingle_unittests\": \"15ff152d0fc7f0bb203c9a5dae3200b36529f5d2\", \"latency_unittests\": \"0aa3b3ad262567ef957dfcda23c699f3f9ef2465\", \"libjingle_xmpp_unittests\": \"dc111ed2cd4f3557840b981ede648b671ed6042f\", \"media_blink_unittests\": \"9fd35b38a45c6dba9de3ccfc1b2aca1b959e7876\", \"media_service_unittests\": \"dcd73a11ae3c879b4928caa3c4814ac6ecbb2ed7\", \"media_unittests\": \"9d9fa60a5028767453478fa10dcdc2c40ac204a0\", \"midi_unittests\": \"e0402800ad9d96af7e77e171bafcea4031936277\", \"mojo_test_apk\": \"a809f9479c7b1b06bd05426871869eb308427dcb\", \"mojo_unittests\": \"331ad60936e307f299ec8c5f2693d0ac72d3baba\", \"net_unittests\": \"41d55de7f44c61896869f134a4698fb3175a46af\", \"sandbox_linux_unittests\": \"7c885d7f4d51f8c275a313503ded6433edb11ed2\", \"services_unittests\": \"5a4a54125fe96e489f0bcca039b1ce3058361192\", \"shell_dialogs_unittests\": \"845d9ab555abb36658df636105858e02c53850dd\", \"skia_unittests\": \"46746e8953a92ed007c034aebcbb842858ccddf8\", \"sql_unittests\": \"3f91495e033c4360d3fe7fab5329a03d5d44839c\", \"storage_unittests\": \"ea3bc17bbad8fffd61e93f8bbebf9cb06700c24e\", \"ui_android_unittests\": \"1f4a4489da8d7b3601c2ca19054c10e5a2420494\", \"ui_base_unittests\": \"34f3de3261a18442b1a9e36ed38da509b8e7d0d4\", \"ui_touch_selection_unittests\": \"a13fa54febcbf07b2cca134df64dd8c600d4fcba\", \"unit_tests\": \"decbd52da3eb3c0a73f2874d04cf2d26c6bbae5e\", \"url_unittests\": \"bddc2732a8c3c66fe4363cbe2b27b876d4e1f914\", \"viz_unittests\": \"dd994a79e081a0ce9607d654fcd859b5851855a8\", \"vr_android_unittests\": \"fa8ea72a69526ae665bd75399086da11d8a74568\", \"vr_common_unittests\": \"dc884e4b016d2bcf3c125947c54a16e4e7df2b95\", \"vr_pixeltests\": \"57440de1bde42f276aa736035e7632342edcb4b8\", \"webview_instrumentation_test_apk\": \"9fc00bc4000aaecbc5f38cf2685bda6950e273ff\", \"wtf_unittests\": \"982300b603afcefd7a4bb2e69c6c05bd080332f0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1cf5addf4d1b07dee05bb817410abedd1ddd14dde2cca1baf3f95933882f5cfd_v2\", \"builder_5ec5ff74a458bedd5b8e8720dafd1328e100d226c0ba3d586e5dff168e611263_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-3-cp80\"], \"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**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#testCannotSelectPromo\\n\\n**chrome_public_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testSmallDrag_Down_MixedFoldersAndBookmarks\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testSmallDrag_Up_BookmarksOnly\"}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1563935018642934",
"status": "COMPLETED",
"status_changed_ts": "1563935018915576",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/2100",
"builder:android-code-coverage",
"buildset:commit/git/42a20608bc0658c89c368ccae584525359e3c084",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42a20608bc0658c89c368ccae584525359e3c084",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072519055097406576",
"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/8907088992912141568/+/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:463a9c0e0dda4910",
"user_agent:luci-scheduler"
],
"updated_ts": "1563938458852673",
"url": "https://ci.chromium.org/b/8907088992912141568",
"utcnow_ts": "1563938459986405"
}
}
[03:21:00.019] Invocation finished in 57m25.763735871s with status FAILED