[13:01:20.306] New invocation is queued and will start shortly
[13:01:21.390] Starting the invocation (attempt 1)
[13:01:21.471] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:01:21.471] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:01:21.471] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9071663557557359456",
"parameters_json": "{\"builder_name\":\"android-code-coverage\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"ad714822b2abd678919cc88c69f45154429066b3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-code-coverage",
"scheduler_invocation_id:9071663557557359456",
"scheduler_job_id:chromium/android-code-coverage",
"user_agent:luci-scheduler",
"buildset:commit/git/ad714822b2abd678919cc88c69f45154429066b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ad714822b2abd678919cc88c69f45154429066b3",
"gitiles_ref:refs/heads/master"
]
}
[13:01:24.952] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1564750882373862",
"id": "8906233494723321088",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ad714822b2abd678919cc88c69f45154429066b3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1564750883679904",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/2312",
"builder:android-code-coverage",
"buildset:commit/git/ad714822b2abd678919cc88c69f45154429066b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ad714822b2abd678919cc88c69f45154429066b3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071663557557359456",
"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/8906233494723321088/+/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": "1564750883680026",
"url": "https://ci.chromium.org/b/8906233494723321088",
"utcnow_ts": "1564750884909417"
}
}
[13:01:24.952] Task URL: https://ci.chromium.org/b/8906233494723321088
[13:01:24.952] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:2:0) after 1m0s
[13:02:11.159] Received PubSub notification, asking Buildbucket for the build status
[13:02:11.270] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:24.979] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:2:0)
[13:02:24.979] Timer tick, asking Buildbucket for the build status
[13:02:27.171] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:27.171] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:4:0) after 1m0s
[13:03:27.192] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:4:0)
[13:03:27.192] Timer tick, asking Buildbucket for the build status
[13:03:28.922] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:28.922] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:5:0) after 1m0s
[13:04:28.945] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:5:0)
[13:04:28.945] Timer tick, asking Buildbucket for the build status
[13:04:29.221] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:29.221] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:6:0) after 1m0s
[13:05:29.368] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:6:0)
[13:05:29.368] Timer tick, asking Buildbucket for the build status
[13:05:29.779] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:29.779] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:7:0) after 1m0s
[13:06:29.803] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:7:0)
[13:06:29.803] Timer tick, asking Buildbucket for the build status
[13:06:30.436] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:30.436] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:8:0) after 1m0s
[13:07:30.419] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:8:0)
[13:07:30.419] Timer tick, asking Buildbucket for the build status
[13:07:31.181] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:31.181] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:9:0) after 1m0s
[13:08:32.502] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:9:0)
[13:08:32.502] Timer tick, asking Buildbucket for the build status
[13:08:33.228] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:33.228] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:10:0) after 1m0s
[13:09:34.959] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:10:0)
[13:09:34.959] Timer tick, asking Buildbucket for the build status
[13:09:35.378] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:35.378] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:11:0) after 1m0s
[13:10:35.517] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:11:0)
[13:10:35.517] Timer tick, asking Buildbucket for the build status
[13:10:36.721] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:36.721] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:12:0) after 1m0s
[13:11:36.882] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:12:0)
[13:11:36.882] Timer tick, asking Buildbucket for the build status
[13:11:37.693] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:37.693] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:13:0) after 1m0s
[13:12:37.730] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:13:0)
[13:12:37.730] Timer tick, asking Buildbucket for the build status
[13:12:37.904] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:37.904] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:14:0) after 1m0s
[13:13:37.948] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:14:0)
[13:13:37.948] Timer tick, asking Buildbucket for the build status
[13:13:38.441] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:38.441] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:15:0) after 1m0s
[13:14:38.445] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:15:0)
[13:14:38.445] Timer tick, asking Buildbucket for the build status
[13:14:38.638] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:38.638] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:16:0) after 1m0s
[13:15:38.662] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:16:0)
[13:15:38.662] Timer tick, asking Buildbucket for the build status
[13:15:38.907] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:38.907] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:17:0) after 1m0s
[13:16:39.006] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:17:0)
[13:16:39.006] Timer tick, asking Buildbucket for the build status
[13:16:39.175] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:39.175] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:18:0) after 1m0s
[13:17:39.267] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:18:0)
[13:17:39.267] Timer tick, asking Buildbucket for the build status
[13:17:40.396] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:40.396] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:19:0) after 1m0s
[13:18:40.455] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:19:0)
[13:18:40.455] Timer tick, asking Buildbucket for the build status
[13:18:40.841] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:40.841] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:20:0) after 1m0s
[13:19:40.964] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:20:0)
[13:19:40.964] Timer tick, asking Buildbucket for the build status
[13:19:41.230] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:41.230] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:21:0) after 1m0s
[13:20:41.308] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:21:0)
[13:20:41.308] Timer tick, asking Buildbucket for the build status
[13:20:42.478] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:42.478] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:22:0) after 1m0s
[13:21:42.505] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:22:0)
[13:21:42.505] Timer tick, asking Buildbucket for the build status
[13:21:44.859] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:44.859] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:23:0) after 1m0s
[13:22:44.911] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:23:0)
[13:22:44.911] Timer tick, asking Buildbucket for the build status
[13:22:45.620] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:45.620] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:24:0) after 1m0s
[13:23:45.744] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:24:0)
[13:23:45.744] Timer tick, asking Buildbucket for the build status
[13:23:46.444] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:46.444] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:25:0) after 1m0s
[13:24:46.548] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:25:0)
[13:24:46.548] Timer tick, asking Buildbucket for the build status
[13:24:48.422] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:48.422] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:26:0) after 1m0s
[13:25:48.663] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:26:0)
[13:25:48.663] Timer tick, asking Buildbucket for the build status
[13:25:49.787] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:49.787] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:27:0) after 1m0s
[13:26:49.953] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:27:0)
[13:26:49.953] Timer tick, asking Buildbucket for the build status
[13:26:50.404] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:50.404] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:28:0) after 1m0s
[13:27:50.474] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:28:0)
[13:27:50.474] Timer tick, asking Buildbucket for the build status
[13:27:50.705] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:50.705] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:29:0) after 1m0s
[13:28:50.813] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:29:0)
[13:28:50.814] Timer tick, asking Buildbucket for the build status
[13:28:51.104] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:51.104] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:30:0) after 1m0s
[13:29:51.143] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:30:0)
[13:29:51.143] Timer tick, asking Buildbucket for the build status
[13:29:53.396] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:53.396] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:31:0) after 1m0s
[13:30:53.631] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:31:0)
[13:30:53.631] Timer tick, asking Buildbucket for the build status
[13:30:54.059] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:54.059] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:32:0) after 1m0s
[13:31:54.250] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:32:0)
[13:31:54.250] Timer tick, asking Buildbucket for the build status
[13:31:55.400] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:55.400] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:33:0) after 1m0s
[13:32:55.482] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:33:0)
[13:32:55.482] Timer tick, asking Buildbucket for the build status
[13:32:55.822] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:55.822] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:34:0) after 1m0s
[13:33:55.948] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:34:0)
[13:33:55.948] Timer tick, asking Buildbucket for the build status
[13:33:56.484] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:56.484] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:35:0) after 1m0s
[13:34:56.621] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:35:0)
[13:34:56.621] Timer tick, asking Buildbucket for the build status
[13:34:56.921] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:56.921] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:36:0) after 1m0s
[13:35:57.140] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:36:0)
[13:35:57.140] Timer tick, asking Buildbucket for the build status
[13:35:59.896] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:59.896] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:37:0) after 1m0s
[13:36:59.922] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:37:0)
[13:36:59.922] Timer tick, asking Buildbucket for the build status
[13:37:00.624] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:00.624] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:38:0) after 1m0s
[13:38:00.721] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:38:0)
[13:38:00.721] Timer tick, asking Buildbucket for the build status
[13:38:01.598] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:01.598] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:39:0) after 1m0s
[13:39:01.632] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:39:0)
[13:39:01.632] Timer tick, asking Buildbucket for the build status
[13:39:02.342] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:02.342] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:40:0) after 1m0s
[13:40:02.393] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:40:0)
[13:40:02.393] Timer tick, asking Buildbucket for the build status
[13:40:02.619] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:02.619] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:41:0) after 1m0s
[13:41:02.799] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:41:0)
[13:41:02.799] Timer tick, asking Buildbucket for the build status
[13:41:05.874] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:05.874] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:42:0) after 1m0s
[13:42:05.909] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:42:0)
[13:42:05.909] Timer tick, asking Buildbucket for the build status
[13:42:07.668] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:07.668] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:43:0) after 1m0s
[13:43:07.756] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:43:0)
[13:43:07.756] Timer tick, asking Buildbucket for the build status
[13:43:08.136] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:08.136] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:44:0) after 1m0s
[13:44:08.173] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:44:0)
[13:44:08.173] Timer tick, asking Buildbucket for the build status
[13:44:08.869] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:08.869] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:45:0) after 1m0s
[13:45:08.898] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:45:0)
[13:45:08.898] Timer tick, asking Buildbucket for the build status
[13:45:09.033] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:09.033] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:46:0) after 1m0s
[13:46:09.098] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:46:0)
[13:46:09.098] Timer tick, asking Buildbucket for the build status
[13:46:09.644] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:09.644] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:47:0) after 1m0s
[13:47:09.754] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:47:0)
[13:47:09.754] Timer tick, asking Buildbucket for the build status
[13:47:10.361] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:10.361] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:48:0) after 1m0s
[13:48:10.386] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:48:0)
[13:48:10.386] Timer tick, asking Buildbucket for the build status
[13:48:10.544] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:10.544] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:49:0) after 1m0s
[13:49:10.598] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:49:0)
[13:49:10.598] Timer tick, asking Buildbucket for the build status
[13:49:10.826] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:10.826] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:50:0) after 1m0s
[13:50:10.844] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:50:0)
[13:50:10.845] Timer tick, asking Buildbucket for the build status
[13:50:12.840] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:12.840] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:51:0) after 1m0s
[13:51:12.997] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:51:0)
[13:51:12.997] Timer tick, asking Buildbucket for the build status
[13:51:13.177] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:13.177] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:52:0) after 1m0s
[13:52:13.286] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:52:0)
[13:52:13.286] Timer tick, asking Buildbucket for the build status
[13:52:13.985] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:13.985] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:53:0) after 1m0s
[13:53:14.118] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:53:0)
[13:53:14.118] Timer tick, asking Buildbucket for the build status
[13:53:14.579] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:14.579] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:54:0) after 1m0s
[13:54:14.688] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:54:0)
[13:54:14.688] Timer tick, asking Buildbucket for the build status
[13:54:15.083] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:15.083] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:55:0) after 1m0s
[13:55:15.121] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:55:0)
[13:55:15.121] Timer tick, asking Buildbucket for the build status
[13:55:15.761] Build 8906233494723321088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:15.761] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9071663557557359456:56:0) after 1m0s
[13:56:01.048] Received PubSub notification, asking Buildbucket for the build status
[13:56:01.732] Build 8906233494723321088: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:56:01.732] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1564754160352641",
"created_by": "project:chromium",
"created_ts": "1564750882373862",
"failure_reason": "BUILD_FAILURE",
"id": "8906233494723321088",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ad714822b2abd678919cc88c69f45154429066b3\"}}",
"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#testEndIconVisibilityInSelectionMode\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testPartnerFolderDraggability\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testEndIconVisiblityInSearchMode\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testPromoDraggability\\n\\n...8 more failure(s) (12 total)...\"}, \"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-i5gy\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-code-coverage\", \"buildnumber\": 2312, \"coverage_gs_bucket\": \"code-coverage-data\", \"coverage_metadata_gs_path\": \"postsubmit/chromium.googlesource.com/chromium/src/ad714822b2abd678919cc88c69f45154429066b3/ci/android-code-coverage/8906233494723321088/java_metadata\", \"got_angle_revision\": \"017c9d8ea78b0945f9034b91e85166f94a57dd9e\", \"got_dawn_revision\": \"c1583a558c5898098423bc2de0b9da1ab04f4770\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"ad714822b2abd678919cc88c69f45154429066b3\", \"got_revision_cp\": \"refs/heads/master@{#683558}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"9ccf13ebe2dc194d0fb93733a7d391b1b29c6de4\", \"got_v8_revision_cp\": \"refs/heads/7.8.54@{#1}\", \"got_webrtc_revision\": \"59bbd65561111fe25e8f0d481e64962598e7c87f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28745}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ad714822b2abd678919cc88c69f45154429066b3\", \"swarm_hashes\": {\"android_browsertests\": \"1db2bc0cc1f039361c450f76f9111e3c556f8c32\", \"android_webview_unittests\": \"4241e6ffd9573b6045780b2c607274c2af1c5037\", \"angle_unittests\": \"dd09d4dfc8918b81579ff29a9c7f5fb120d245a4\", \"base_unittests\": \"ba0b9a40ae5975ac9ac3f7e155157e0af4ed0cf6\", \"base_util_unittests\": \"ce73d2dd637b77db41692bbcca0d5f0154e6aec4\", \"blink_common_unittests\": \"f8e09b806ae4166ca878ef0b42cabdf726fac541\", \"blink_heap_unittests\": \"9359529c939bfd75f119922facd404e1bbb9de96\", \"blink_platform_unittests\": \"e5c61efd05e18684afee10ab5de67c6b940ababc\", \"blink_unittests\": \"c96fa3cfe706dd1794fd07793915e1ddb06a4a0a\", \"boringssl_crypto_tests\": \"7d35770fc67503154da26fd8a23edfd45b940711\", \"boringssl_ssl_tests\": \"2f88b9a9e88c499fa2a053cff21fe445bcbf3220\", \"breakpad_unittests\": \"348a4935e4bef673cf91ba5179f85c648d40469b\", \"cacheinvalidation_unittests\": \"c385f8c1cba910bf8080a432240242bf10ec4e3a\", \"capture_unittests\": \"479b71946770db3b08618eacdf91109df21fc349\", \"cast_unittests\": \"1c2dbca7e1ec4b4df922426bd0e68fc26f466cf9\", \"cc_unittests\": \"334afcee3e64689dcbe029f2e9771f3f79d23b77\", \"chrome_public_test_apk\": \"c2d838d1fc9d660d24878019301320898ae6d890\", \"chrome_public_test_vr_apk\": \"2973c837ac4209052894856cfb1d438a083b0b73\", \"components_browsertests\": \"8566f827b55cdadc7a032095eec50dd725541862\", \"components_unittests\": \"0a67f1f0411c00589e10e9738838dcb061d343db\", \"content_browsertests\": \"372ef119403959bb2b629777d004c38f74baa6ce\", \"content_shell_test_apk\": \"af3c385f316e0d135008141715b03f9e48ecfe67\", \"content_unittests\": \"ecd73e154acc434ff080da64943bab769472da5e\", \"crypto_unittests\": \"47c3a26ed5d378865d1ca973a07a522e99373de9\", \"device_unittests\": \"3d11febfd9fc3fb8633132e9dd85e99f9109ce8e\", \"display_unittests\": \"0da657b19bc99da3431e7fad3329143d391b4202\", \"events_unittests\": \"51af3663f2a128ca426093b63fc3227d8a0b5c64\", \"gcm_unit_tests\": \"82fbcecbd21d9f0c4975aa37aafdab766bf8f890\", \"gfx_unittests\": \"6e6ccb891b1448f413ef73c4c2f8c38a87836170\", \"gin_unittests\": \"fde2b0c2a2618dd2d1eb1c0a35db74f02c4f6da9\", \"gl_tests\": \"4c742033919597c83c567fd4b06cde31398806f4\", \"gl_unittests\": \"a13fbf80ed0657dfbd1ec6563667dc9e9a2e2184\", \"google_apis_unittests\": \"05146079d85b0e5c4c7b4435741cb4f1d668ef5b\", \"gpu_unittests\": \"2829902de67bb654b724f87f0dce4272e51edf2b\", \"ipc_tests\": \"24fd6e09a17b7843a81b973f3747b16902b1c3e8\", \"jingle_unittests\": \"c801fac1275af781f3de81d2d9e0451ed0d87fc3\", \"latency_unittests\": \"b64d419e5336258b412dcf4b5eab690b0de4ea69\", \"libjingle_xmpp_unittests\": \"92d2377f05e3e4deaf6bda7d3b6d1f1986c2f26d\", \"media_blink_unittests\": \"ac22aba4a9f748c670a0a24fc581b7e00165c615\", \"media_service_unittests\": \"98cff87731c6e7b7613da42995f66879a3e8c449\", \"media_unittests\": \"d2898aeed1b8c739d64f1fac467e56b4f276dad6\", \"midi_unittests\": \"5a2e924974ddb2f1d8d54a2031dff4d05c2f7250\", \"mojo_test_apk\": \"ecc2b2e667c8ecbd2f3b03776a0fdc83c689153e\", \"mojo_unittests\": \"04d95711cb6090a10fdd856c82b5afa44c8eae63\", \"net_unittests\": \"48d042af960069489415d4db6a8e529e2e41227a\", \"sandbox_linux_unittests\": \"1a25e2586d1a349e3f89ff38d86ee58139a0cb30\", \"services_unittests\": \"b5c166f6bb9e27fa797881c7e91be7e57c1ac2bf\", \"shell_dialogs_unittests\": \"a0c4e0b871a77e62952b68f480c7946430e3b8f8\", \"skia_unittests\": \"bcccf137381dcb587bbe77bd7c74e06a8962b6cf\", \"sql_unittests\": \"0ca09c9bd5e41f935a01c13ad3151660ebf36652\", \"storage_unittests\": \"d1c10d71817116279efb95e0b6d465b28ce8419c\", \"ui_android_unittests\": \"052c92d665f7ae63b7c2b08cf1e7fc877aa1f720\", \"ui_base_unittests\": \"3da54290100afe331879d7e021c60813636f130f\", \"ui_touch_selection_unittests\": \"168e1f5b2d3d4cb05f23c84d7385cd31bdd7fe8a\", \"unit_tests\": \"b2998fc07a0bcdfa87afb309977862f38f12310b\", \"url_unittests\": \"f3a0abd44270b9f97d13db7cc14bbaa1a5b58009\", \"viz_unittests\": \"3d4c6a3d0778d42a14a98599e3e984294b7a5675\", \"vr_android_unittests\": \"0f3e54036a7acce7c202b9f5157360dc7c173868\", \"vr_common_unittests\": \"5e35649a8be3c960764c03cd353f72ba0cf8cd8b\", \"vr_pixeltests\": \"991c72f77eb845ef89209babcc20370367505db5\", \"webview_instrumentation_test_apk\": \"2c1b78fff95d0e8a90f1380f6a97acfac852103f\", \"wtf_unittests\": \"f61b7302f0dbcca9b2caf3f3f397a34d2d1681d9\"}, \"swarm_hashes_refs/heads/master(at){#683558}_without_patch\": {\"android_browsertests\": \"1db2bc0cc1f039361c450f76f9111e3c556f8c32\", \"android_webview_unittests\": \"4241e6ffd9573b6045780b2c607274c2af1c5037\", \"angle_unittests\": \"dd09d4dfc8918b81579ff29a9c7f5fb120d245a4\", \"base_unittests\": \"ba0b9a40ae5975ac9ac3f7e155157e0af4ed0cf6\", \"base_util_unittests\": \"ce73d2dd637b77db41692bbcca0d5f0154e6aec4\", \"blink_common_unittests\": \"f8e09b806ae4166ca878ef0b42cabdf726fac541\", \"blink_heap_unittests\": \"9359529c939bfd75f119922facd404e1bbb9de96\", \"blink_platform_unittests\": \"e5c61efd05e18684afee10ab5de67c6b940ababc\", \"blink_unittests\": \"c96fa3cfe706dd1794fd07793915e1ddb06a4a0a\", \"boringssl_crypto_tests\": \"7d35770fc67503154da26fd8a23edfd45b940711\", \"boringssl_ssl_tests\": \"2f88b9a9e88c499fa2a053cff21fe445bcbf3220\", \"breakpad_unittests\": \"348a4935e4bef673cf91ba5179f85c648d40469b\", \"cacheinvalidation_unittests\": \"c385f8c1cba910bf8080a432240242bf10ec4e3a\", \"capture_unittests\": \"479b71946770db3b08618eacdf91109df21fc349\", \"cast_unittests\": \"1c2dbca7e1ec4b4df922426bd0e68fc26f466cf9\", \"cc_unittests\": \"334afcee3e64689dcbe029f2e9771f3f79d23b77\", \"chrome_public_test_apk\": \"c2d838d1fc9d660d24878019301320898ae6d890\", \"chrome_public_test_vr_apk\": \"2973c837ac4209052894856cfb1d438a083b0b73\", \"components_browsertests\": \"8566f827b55cdadc7a032095eec50dd725541862\", \"components_unittests\": \"0a67f1f0411c00589e10e9738838dcb061d343db\", \"content_browsertests\": \"372ef119403959bb2b629777d004c38f74baa6ce\", \"content_shell_test_apk\": \"af3c385f316e0d135008141715b03f9e48ecfe67\", \"content_unittests\": \"ecd73e154acc434ff080da64943bab769472da5e\", \"crypto_unittests\": \"47c3a26ed5d378865d1ca973a07a522e99373de9\", \"device_unittests\": \"3d11febfd9fc3fb8633132e9dd85e99f9109ce8e\", \"display_unittests\": \"0da657b19bc99da3431e7fad3329143d391b4202\", \"events_unittests\": \"51af3663f2a128ca426093b63fc3227d8a0b5c64\", \"gcm_unit_tests\": \"82fbcecbd21d9f0c4975aa37aafdab766bf8f890\", \"gfx_unittests\": \"6e6ccb891b1448f413ef73c4c2f8c38a87836170\", \"gin_unittests\": \"fde2b0c2a2618dd2d1eb1c0a35db74f02c4f6da9\", \"gl_tests\": \"4c742033919597c83c567fd4b06cde31398806f4\", \"gl_unittests\": \"a13fbf80ed0657dfbd1ec6563667dc9e9a2e2184\", \"google_apis_unittests\": \"05146079d85b0e5c4c7b4435741cb4f1d668ef5b\", \"gpu_unittests\": \"2829902de67bb654b724f87f0dce4272e51edf2b\", \"ipc_tests\": \"24fd6e09a17b7843a81b973f3747b16902b1c3e8\", \"jingle_unittests\": \"c801fac1275af781f3de81d2d9e0451ed0d87fc3\", \"latency_unittests\": \"b64d419e5336258b412dcf4b5eab690b0de4ea69\", \"libjingle_xmpp_unittests\": \"92d2377f05e3e4deaf6bda7d3b6d1f1986c2f26d\", \"media_blink_unittests\": \"ac22aba4a9f748c670a0a24fc581b7e00165c615\", \"media_service_unittests\": \"98cff87731c6e7b7613da42995f66879a3e8c449\", \"media_unittests\": \"d2898aeed1b8c739d64f1fac467e56b4f276dad6\", \"midi_unittests\": \"5a2e924974ddb2f1d8d54a2031dff4d05c2f7250\", \"mojo_test_apk\": \"ecc2b2e667c8ecbd2f3b03776a0fdc83c689153e\", \"mojo_unittests\": \"04d95711cb6090a10fdd856c82b5afa44c8eae63\", \"net_unittests\": \"48d042af960069489415d4db6a8e529e2e41227a\", \"sandbox_linux_unittests\": \"1a25e2586d1a349e3f89ff38d86ee58139a0cb30\", \"services_unittests\": \"b5c166f6bb9e27fa797881c7e91be7e57c1ac2bf\", \"shell_dialogs_unittests\": \"a0c4e0b871a77e62952b68f480c7946430e3b8f8\", \"skia_unittests\": \"bcccf137381dcb587bbe77bd7c74e06a8962b6cf\", \"sql_unittests\": \"0ca09c9bd5e41f935a01c13ad3151660ebf36652\", \"storage_unittests\": \"d1c10d71817116279efb95e0b6d465b28ce8419c\", \"ui_android_unittests\": \"052c92d665f7ae63b7c2b08cf1e7fc877aa1f720\", \"ui_base_unittests\": \"3da54290100afe331879d7e021c60813636f130f\", \"ui_touch_selection_unittests\": \"168e1f5b2d3d4cb05f23c84d7385cd31bdd7fe8a\", \"unit_tests\": \"b2998fc07a0bcdfa87afb309977862f38f12310b\", \"url_unittests\": \"f3a0abd44270b9f97d13db7cc14bbaa1a5b58009\", \"viz_unittests\": \"3d4c6a3d0778d42a14a98599e3e984294b7a5675\", \"vr_android_unittests\": \"0f3e54036a7acce7c202b9f5157360dc7c173868\", \"vr_common_unittests\": \"5e35649a8be3c960764c03cd353f72ba0cf8cd8b\", \"vr_pixeltests\": \"991c72f77eb845ef89209babcc20370367505db5\", \"webview_instrumentation_test_apk\": \"2c1b78fff95d0e8a90f1380f6a97acfac852103f\", \"wtf_unittests\": \"f61b7302f0dbcca9b2caf3f3f397a34d2d1681d9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-i5gy\"], \"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#testEndIconVisibilityInSelectionMode\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testPartnerFolderDraggability\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testEndIconVisiblityInSearchMode\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testPromoDraggability\\n\\n...8 more failure(s) (12 total)...\"}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1564750929498113",
"status": "COMPLETED",
"status_changed_ts": "1564750930698987",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/2312",
"builder:android-code-coverage",
"buildset:commit/git/ad714822b2abd678919cc88c69f45154429066b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ad714822b2abd678919cc88c69f45154429066b3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071663557557359456",
"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/8906233494723321088/+/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:466b3d383806ce10",
"user_agent:luci-scheduler"
],
"updated_ts": "1564754160702001",
"url": "https://ci.chromium.org/b/8906233494723321088",
"utcnow_ts": "1564754161720644"
}
}
[13:56:01.732] Invocation finished in 54m41.445852986s with status FAILED