[10:05:26.196] New invocation is queued and will start shortly
[10:05:27.364] Starting the invocation (attempt 1)
[10:05:27.402] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:05:27.403] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:05:27.403] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9072580594006956816",
"parameters_json": "{\"builder_name\":\"android-code-coverage\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"f38f89947f192f5717195a09d966c4ddef891b78\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-code-coverage",
"scheduler_invocation_id:9072580594006956816",
"scheduler_job_id:chromium/android-code-coverage",
"user_agent:luci-scheduler",
"buildset:commit/git/f38f89947f192f5717195a09d966c4ddef891b78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f38f89947f192f5717195a09d966c4ddef891b78",
"gitiles_ref:refs/heads/master"
]
}
[10:05:28.921] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563876327776989",
"id": "8907150531684186256",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f38f89947f192f5717195a09d966c4ddef891b78\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563876328423082",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/2087",
"builder:android-code-coverage",
"buildset:commit/git/f38f89947f192f5717195a09d966c4ddef891b78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f38f89947f192f5717195a09d966c4ddef891b78",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072580594006956816",
"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/8907150531684186256/+/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": "1563876328423204",
"url": "https://ci.chromium.org/b/8907150531684186256",
"utcnow_ts": "1563876328910075"
}
}
[10:05:28.921] Task URL: https://ci.chromium.org/b/8907150531684186256
[10:05:28.921] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:2:0) after 1m0s
[10:06:28.992] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:2:0)
[10:06:28.992] Timer tick, asking Buildbucket for the build status
[10:06:29.164] Build 8907150531684186256: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:06:29.164] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:3:0) after 1m0s
[10:06:34.141] Received PubSub notification, asking Buildbucket for the build status
[10:06:34.267] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:29.342] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:3:0)
[10:07:29.342] Timer tick, asking Buildbucket for the build status
[10:07:30.871] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:30.871] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:5:0) after 1m0s
[10:08:30.895] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:5:0)
[10:08:30.895] Timer tick, asking Buildbucket for the build status
[10:08:33.266] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:33.266] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:6:0) after 1m0s
[10:09:33.335] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:6:0)
[10:09:33.335] Timer tick, asking Buildbucket for the build status
[10:09:33.522] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:33.522] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:7:0) after 1m0s
[10:10:33.556] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:7:0)
[10:10:33.556] Timer tick, asking Buildbucket for the build status
[10:10:33.747] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:33.747] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:8:0) after 1m0s
[10:11:33.833] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:8:0)
[10:11:33.833] Timer tick, asking Buildbucket for the build status
[10:11:34.410] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:34.410] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:9:0) after 1m0s
[10:12:34.430] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:9:0)
[10:12:34.430] Timer tick, asking Buildbucket for the build status
[10:12:35.528] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:35.528] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:10:0) after 1m0s
[10:13:35.539] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:10:0)
[10:13:35.539] Timer tick, asking Buildbucket for the build status
[10:13:35.863] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:35.863] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:11:0) after 1m0s
[10:14:35.865] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:11:0)
[10:14:35.865] Timer tick, asking Buildbucket for the build status
[10:14:36.414] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:36.414] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:12:0) after 1m0s
[10:15:36.439] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:12:0)
[10:15:36.439] Timer tick, asking Buildbucket for the build status
[10:15:36.974] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:36.974] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:13:0) after 1m0s
[10:16:37.041] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:13:0)
[10:16:37.041] Timer tick, asking Buildbucket for the build status
[10:16:37.219] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:37.219] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:14:0) after 1m0s
[10:17:37.320] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:14:0)
[10:17:37.320] Timer tick, asking Buildbucket for the build status
[10:17:38.217] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:38.217] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:15:0) after 1m0s
[10:18:38.273] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:15:0)
[10:18:38.273] Timer tick, asking Buildbucket for the build status
[10:18:39.222] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:39.222] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:16:0) after 1m0s
[10:19:39.247] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:16:0)
[10:19:39.247] Timer tick, asking Buildbucket for the build status
[10:19:39.657] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:39.657] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:17:0) after 1m0s
[10:20:39.674] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:17:0)
[10:20:39.674] Timer tick, asking Buildbucket for the build status
[10:20:40.747] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:40.747] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:18:0) after 1m0s
[10:21:40.734] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:18:0)
[10:21:40.734] Timer tick, asking Buildbucket for the build status
[10:21:41.457] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:41.457] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:19:0) after 1m0s
[10:22:41.468] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:19:0)
[10:22:41.468] Timer tick, asking Buildbucket for the build status
[10:22:42.183] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:42.183] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:20:0) after 1m0s
[10:23:42.208] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:20:0)
[10:23:42.208] Timer tick, asking Buildbucket for the build status
[10:23:42.434] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:42.434] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:21:0) after 1m0s
[10:24:42.454] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:21:0)
[10:24:42.454] Timer tick, asking Buildbucket for the build status
[10:24:43.500] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:43.500] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:22:0) after 1m0s
[10:25:43.564] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:22:0)
[10:25:43.564] Timer tick, asking Buildbucket for the build status
[10:25:43.966] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:43.966] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:23:0) after 1m0s
[10:26:43.963] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:23:0)
[10:26:43.963] Timer tick, asking Buildbucket for the build status
[10:26:45.260] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:45.260] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:24:0) after 1m0s
[10:27:45.261] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:24:0)
[10:27:45.261] Timer tick, asking Buildbucket for the build status
[10:27:45.931] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:45.931] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:25:0) after 1m0s
[10:28:45.953] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:25:0)
[10:28:45.953] Timer tick, asking Buildbucket for the build status
[10:28:46.168] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:46.168] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:26:0) after 1m0s
[10:29:46.192] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:26:0)
[10:29:46.192] Timer tick, asking Buildbucket for the build status
[10:29:46.550] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:46.550] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:27:0) after 1m0s
[10:30:46.574] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:27:0)
[10:30:46.574] Timer tick, asking Buildbucket for the build status
[10:30:46.750] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:46.750] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:28:0) after 1m0s
[10:31:46.798] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:28:0)
[10:31:46.798] Timer tick, asking Buildbucket for the build status
[10:31:47.169] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:47.169] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:29:0) after 1m0s
[10:32:47.243] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:29:0)
[10:32:47.243] Timer tick, asking Buildbucket for the build status
[10:32:47.598] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:47.598] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:30:0) after 1m0s
[10:33:47.689] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:30:0)
[10:33:47.689] Timer tick, asking Buildbucket for the build status
[10:33:48.083] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:48.083] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:31:0) after 1m0s
[10:34:48.196] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:31:0)
[10:34:48.196] Timer tick, asking Buildbucket for the build status
[10:34:48.592] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:48.592] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:32:0) after 1m0s
[10:35:48.613] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:32:0)
[10:35:48.613] Timer tick, asking Buildbucket for the build status
[10:35:48.791] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:48.791] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:33:0) after 1m0s
[10:36:48.813] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:33:0)
[10:36:48.813] Timer tick, asking Buildbucket for the build status
[10:36:49.195] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:49.196] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:34:0) after 1m0s
[10:37:49.236] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:34:0)
[10:37:49.236] Timer tick, asking Buildbucket for the build status
[10:37:49.495] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:49.495] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:35:0) after 1m0s
[10:38:49.517] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:35:0)
[10:38:49.517] Timer tick, asking Buildbucket for the build status
[10:38:49.777] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:49.777] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:36:0) after 1m0s
[10:39:50.147] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:36:0)
[10:39:50.147] Timer tick, asking Buildbucket for the build status
[10:39:50.926] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:50.926] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:37:0) after 1m0s
[10:40:51.175] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:37:0)
[10:40:51.175] Timer tick, asking Buildbucket for the build status
[10:40:51.553] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:51.553] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:38:0) after 1m0s
[10:41:51.737] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:38:0)
[10:41:51.737] Timer tick, asking Buildbucket for the build status
[10:41:52.094] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:52.094] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:39:0) after 1m0s
[10:42:52.220] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:39:0)
[10:42:52.220] Timer tick, asking Buildbucket for the build status
[10:42:53.116] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:53.116] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:40:0) after 1m0s
[10:43:53.188] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:40:0)
[10:43:53.188] Timer tick, asking Buildbucket for the build status
[10:43:53.538] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:53.538] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:41:0) after 1m0s
[10:44:53.613] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:41:0)
[10:44:53.613] Timer tick, asking Buildbucket for the build status
[10:44:53.827] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:53.827] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:42:0) after 1m0s
[10:45:53.818] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:42:0)
[10:45:53.818] Timer tick, asking Buildbucket for the build status
[10:45:54.762] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:54.762] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:43:0) after 1m0s
[10:46:54.956] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:43:0)
[10:46:54.956] Timer tick, asking Buildbucket for the build status
[10:46:55.139] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:55.139] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:44:0) after 1m0s
[10:47:57.482] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:44:0)
[10:47:57.482] Timer tick, asking Buildbucket for the build status
[10:47:57.862] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:57.862] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:45:0) after 1m0s
[10:48:57.897] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:45:0)
[10:48:57.897] Timer tick, asking Buildbucket for the build status
[10:48:58.228] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:58.228] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:46:0) after 1m0s
[10:49:58.254] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:46:0)
[10:49:58.254] Timer tick, asking Buildbucket for the build status
[10:49:58.445] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:58.445] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:47:0) after 1m0s
[10:50:58.614] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:47:0)
[10:50:58.614] Timer tick, asking Buildbucket for the build status
[10:50:58.845] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:58.845] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:48:0) after 1m0s
[10:51:58.884] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:48:0)
[10:51:58.884] Timer tick, asking Buildbucket for the build status
[10:51:59.602] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:59.602] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:49:0) after 1m0s
[10:52:59.650] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:49:0)
[10:52:59.650] Timer tick, asking Buildbucket for the build status
[10:52:59.848] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:59.848] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:50:0) after 1m0s
[10:53:59.930] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:50:0)
[10:53:59.930] Timer tick, asking Buildbucket for the build status
[10:54:00.156] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:00.156] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:51:0) after 1m0s
[10:55:00.257] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:51:0)
[10:55:00.257] Timer tick, asking Buildbucket for the build status
[10:55:00.481] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:00.481] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:52:0) after 1m0s
[10:56:00.613] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:52:0)
[10:56:00.613] Timer tick, asking Buildbucket for the build status
[10:56:00.868] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:00.868] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:53:0) after 1m0s
[10:57:00.992] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:53:0)
[10:57:00.992] Timer tick, asking Buildbucket for the build status
[10:57:01.224] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:01.224] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:54:0) after 1m0s
[10:58:01.538] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:54:0)
[10:58:01.538] Timer tick, asking Buildbucket for the build status
[10:58:01.792] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:01.792] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:55:0) after 1m0s
[10:59:01.853] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:55:0)
[10:59:01.853] Timer tick, asking Buildbucket for the build status
[10:59:02.105] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:02.106] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:56:0) after 1m0s
[11:00:02.149] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:56:0)
[11:00:02.149] Timer tick, asking Buildbucket for the build status
[11:00:02.334] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:02.334] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:57:0) after 1m0s
[11:01:02.369] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:57:0)
[11:01:02.369] Timer tick, asking Buildbucket for the build status
[11:01:02.842] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:02.842] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:58:0) after 1m0s
[11:02:02.884] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:58:0)
[11:02:02.884] Timer tick, asking Buildbucket for the build status
[11:02:03.513] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:03.513] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:59:0) after 1m0s
[11:03:03.643] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:59:0)
[11:03:03.643] Timer tick, asking Buildbucket for the build status
[11:03:03.800] Build 8907150531684186256: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:03.800] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9072580594006956816:60:0) after 1m0s
[11:03:11.410] Received PubSub notification, asking Buildbucket for the build status
[11:03:11.609] Build 8907150531684186256: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:03:11.609] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563879790363512",
"created_by": "project:chromium",
"created_ts": "1563876327776989",
"failure_reason": "BUILD_FAILURE",
"id": "8907150531684186256",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f38f89947f192f5717195a09d966c4ddef891b78\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**chrome_public_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testCannotSelectPartner\\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#testCannotSelectPartner\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testCannotSelectPromo\"}, \"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\": 2087, \"got_angle_revision\": \"02407743bd7261c37abae0f7e4962ea324662122\", \"got_dawn_revision\": \"07b5be3bc5df96b6488bb129eb39248dea078a20\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"f38f89947f192f5717195a09d966c4ddef891b78\", \"got_revision_cp\": \"refs/heads/master@{#679917}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"12c0646785a3207f5cdd747038a9cf9910e2bab5\", \"got_v8_revision_cp\": \"refs/heads/7.7.295@{#1}\", \"got_webrtc_revision\": \"85ef3eab9407a75ce634ae213a2904be862ba542\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28643}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f38f89947f192f5717195a09d966c4ddef891b78\", \"swarm_hashes\": {\"android_browsertests\": \"352db335850e98848466ce23bbadc80032a5ed47\", \"android_webview_unittests\": \"ddca8c7052d7f3be6f3c4f6aea23465731303ab1\", \"angle_unittests\": \"0717c06dea45ee53adf73d7e9a647d4351477509\", \"base_unittests\": \"bbb2ff49ff6c7652631cd22ef7cff2528766a578\", \"base_util_unittests\": \"777f13a169e7980b19b5b0281606b933dd09ff6e\", \"blink_common_unittests\": \"9b7c89d2fd410bf57cedb3f28a864bd4294f3231\", \"blink_heap_unittests\": \"1d7685742f8b55dcd96ef30253a791dc07c4967b\", \"blink_platform_unittests\": \"0795eeeb7c26000eee3ddb9e08b88253fe24222f\", \"blink_unittests\": \"7ba5d3ca23717e10dc03ac107129916221e99081\", \"boringssl_crypto_tests\": \"adc636463e446f0531f4c907d9219238c5862871\", \"boringssl_ssl_tests\": \"9cce98c7c2d41a6e73e76139ae1bfd66e0fa5731\", \"breakpad_unittests\": \"55065af4bb03802c52127f121d2e912fc7f2a63f\", \"cacheinvalidation_unittests\": \"ce0003266fcf99df6efd95b398bfbea96a3a48ba\", \"capture_unittests\": \"8891b8dc6a6e1b60b9fb0ac6dd1bcdab5024ec14\", \"cast_unittests\": \"2bf7d29102d2fd6fccc623d628a4f3c9a0fc9519\", \"cc_unittests\": \"336a2a6781341b83bd02d3ad75fe93854e10de79\", \"chrome_public_test_apk\": \"ebb85b9aa0435d0ff81e852e6fc0f37555da9e53\", \"chrome_public_test_vr_apk\": \"80d1a22067c025db950c59a3666e6df4239ec85b\", \"components_browsertests\": \"d0e36cb2b662685ae607e9df993fe631b3584e30\", \"components_unittests\": \"15677eb693bc4e5e3ec1991ba905d25176516dc3\", \"content_browsertests\": \"299849668e344ec413f24e685ec29f5ff7bdca3a\", \"content_shell_test_apk\": \"dfa0849683772594c8eed82814c62ae88639d603\", \"content_unittests\": \"6bbd57a5e5e55dfe268a0a245909b009f8b12441\", \"crypto_unittests\": \"b7fc127b621aa933bf4a2e1aa69015ff79cfedc5\", \"device_unittests\": \"4b5b6747d0bf817147627b297ea71691ac57471d\", \"display_unittests\": \"55f61b0ab484fda6fed6c1b46fcd4900928ec18b\", \"events_unittests\": \"56a76852718ae32d9cba79ce07d3f744006ef45d\", \"gcm_unit_tests\": \"5af937c1b1cb15b85a41d4b4028599439f53be17\", \"gfx_unittests\": \"1880f3aa535d78e401129a1be37a513de8b8fe1e\", \"gin_unittests\": \"400463bb535bddac4f6fcae102bea46f13e6cdb0\", \"gl_tests\": \"751c10c05ac95960a9e4ec89b5ce6b5cf0555105\", \"gl_unittests\": \"10758ffec661192e15065956386ac5000fc64798\", \"google_apis_unittests\": \"d31a5c805d9e5beaa33c8074d2494cfcf01bca4a\", \"gpu_unittests\": \"fdf54640f2075498135723a85dbd24a4c6a1d8fe\", \"ipc_tests\": \"698f267cbeb3d3e526e2da9f4478ac874a5d1174\", \"jingle_unittests\": \"52d34be6ed5dfaeb63b476fa98bb63e2e861dc30\", \"latency_unittests\": \"8e4893f677564f9c27920d568e6a1474a991b35e\", \"libjingle_xmpp_unittests\": \"d45ac10317c7ae07b5e74da9b7e2126de8a26c17\", \"media_blink_unittests\": \"ff1fd9b1630b66cc5e8800a0dc7e3913bc8f52c5\", \"media_service_unittests\": \"5a91501a1181d8c95cc3bc12ee9d88fda83d1405\", \"media_unittests\": \"22d50f5d206fc8a82cd8d705032503c5feddcd69\", \"midi_unittests\": \"dbd543c701a5463b5a069600f0df994927326f42\", \"mojo_test_apk\": \"7e0e66fdf19db2e55b5a0d092a6669683d82d6c8\", \"mojo_unittests\": \"3dda1bf4b4515502396277ad129e717e67b6418d\", \"net_unittests\": \"3d693723569096a74c42026d7dc9f7d7825cd873\", \"sandbox_linux_unittests\": \"e94c2f6125f761e04907eb9e37139ce90ffc91c7\", \"services_unittests\": \"47b7ea943a884301557d3c82d96695cab79a1d15\", \"shell_dialogs_unittests\": \"a336d0976cfc703d124046197d4406a1313c4f1d\", \"skia_unittests\": \"da5e3bb127cefea38f2ae247efafe4aef9e06f84\", \"sql_unittests\": \"f1699fe02f74854b724a549fd39ce591fb9a9f2a\", \"storage_unittests\": \"7ccd14ab825608db92a2777576dd507560badc81\", \"ui_android_unittests\": \"af965cea364b69db6e6d80243c4b793ad00bada6\", \"ui_base_unittests\": \"2403dc71a1540a1474bd1ffef55ef329388e4850\", \"ui_touch_selection_unittests\": \"2ff3babbd312a7c4251de9a4998ecba249256edf\", \"unit_tests\": \"9772461c3bd90c771714f7b8c982c83f503065ec\", \"url_unittests\": \"7e883312bd1cef996dd2aa02ce09204109f68466\", \"viz_unittests\": \"652a43dd2f925f910823086ddf94fb76b30d6d9e\", \"vr_android_unittests\": \"a13a37fe344d44fe60bb2e98386d9b0e297a2fde\", \"vr_common_unittests\": \"79d67bf9542852156b00419d1f763ea8e65c3ce9\", \"vr_pixeltests\": \"5ed876df4519d12b92293549fa7751f54f869d49\", \"webview_instrumentation_test_apk\": \"adf15c96f4295dfeee86f18803ad3bde2f55b5ab\", \"wtf_unittests\": \"38df771cc7b5d65e2b32c7c03b0360decc634302\"}, \"swarm_hashes_refs/heads/master(at){#679917}_without_patch\": {\"android_browsertests\": \"352db335850e98848466ce23bbadc80032a5ed47\", \"android_webview_unittests\": \"ddca8c7052d7f3be6f3c4f6aea23465731303ab1\", \"angle_unittests\": \"0717c06dea45ee53adf73d7e9a647d4351477509\", \"base_unittests\": \"bbb2ff49ff6c7652631cd22ef7cff2528766a578\", \"base_util_unittests\": \"777f13a169e7980b19b5b0281606b933dd09ff6e\", \"blink_common_unittests\": \"9b7c89d2fd410bf57cedb3f28a864bd4294f3231\", \"blink_heap_unittests\": \"1d7685742f8b55dcd96ef30253a791dc07c4967b\", \"blink_platform_unittests\": \"0795eeeb7c26000eee3ddb9e08b88253fe24222f\", \"blink_unittests\": \"7ba5d3ca23717e10dc03ac107129916221e99081\", \"boringssl_crypto_tests\": \"adc636463e446f0531f4c907d9219238c5862871\", \"boringssl_ssl_tests\": \"9cce98c7c2d41a6e73e76139ae1bfd66e0fa5731\", \"breakpad_unittests\": \"55065af4bb03802c52127f121d2e912fc7f2a63f\", \"cacheinvalidation_unittests\": \"ce0003266fcf99df6efd95b398bfbea96a3a48ba\", \"capture_unittests\": \"8891b8dc6a6e1b60b9fb0ac6dd1bcdab5024ec14\", \"cast_unittests\": \"2bf7d29102d2fd6fccc623d628a4f3c9a0fc9519\", \"cc_unittests\": \"336a2a6781341b83bd02d3ad75fe93854e10de79\", \"chrome_public_test_apk\": \"ebb85b9aa0435d0ff81e852e6fc0f37555da9e53\", \"chrome_public_test_vr_apk\": \"80d1a22067c025db950c59a3666e6df4239ec85b\", \"components_browsertests\": \"d0e36cb2b662685ae607e9df993fe631b3584e30\", \"components_unittests\": \"15677eb693bc4e5e3ec1991ba905d25176516dc3\", \"content_browsertests\": \"299849668e344ec413f24e685ec29f5ff7bdca3a\", \"content_shell_test_apk\": \"dfa0849683772594c8eed82814c62ae88639d603\", \"content_unittests\": \"6bbd57a5e5e55dfe268a0a245909b009f8b12441\", \"crypto_unittests\": \"b7fc127b621aa933bf4a2e1aa69015ff79cfedc5\", \"device_unittests\": \"4b5b6747d0bf817147627b297ea71691ac57471d\", \"display_unittests\": \"55f61b0ab484fda6fed6c1b46fcd4900928ec18b\", \"events_unittests\": \"56a76852718ae32d9cba79ce07d3f744006ef45d\", \"gcm_unit_tests\": \"5af937c1b1cb15b85a41d4b4028599439f53be17\", \"gfx_unittests\": \"1880f3aa535d78e401129a1be37a513de8b8fe1e\", \"gin_unittests\": \"400463bb535bddac4f6fcae102bea46f13e6cdb0\", \"gl_tests\": \"751c10c05ac95960a9e4ec89b5ce6b5cf0555105\", \"gl_unittests\": \"10758ffec661192e15065956386ac5000fc64798\", \"google_apis_unittests\": \"d31a5c805d9e5beaa33c8074d2494cfcf01bca4a\", \"gpu_unittests\": \"fdf54640f2075498135723a85dbd24a4c6a1d8fe\", \"ipc_tests\": \"698f267cbeb3d3e526e2da9f4478ac874a5d1174\", \"jingle_unittests\": \"52d34be6ed5dfaeb63b476fa98bb63e2e861dc30\", \"latency_unittests\": \"8e4893f677564f9c27920d568e6a1474a991b35e\", \"libjingle_xmpp_unittests\": \"d45ac10317c7ae07b5e74da9b7e2126de8a26c17\", \"media_blink_unittests\": \"ff1fd9b1630b66cc5e8800a0dc7e3913bc8f52c5\", \"media_service_unittests\": \"5a91501a1181d8c95cc3bc12ee9d88fda83d1405\", \"media_unittests\": \"22d50f5d206fc8a82cd8d705032503c5feddcd69\", \"midi_unittests\": \"dbd543c701a5463b5a069600f0df994927326f42\", \"mojo_test_apk\": \"7e0e66fdf19db2e55b5a0d092a6669683d82d6c8\", \"mojo_unittests\": \"3dda1bf4b4515502396277ad129e717e67b6418d\", \"net_unittests\": \"3d693723569096a74c42026d7dc9f7d7825cd873\", \"sandbox_linux_unittests\": \"e94c2f6125f761e04907eb9e37139ce90ffc91c7\", \"services_unittests\": \"47b7ea943a884301557d3c82d96695cab79a1d15\", \"shell_dialogs_unittests\": \"a336d0976cfc703d124046197d4406a1313c4f1d\", \"skia_unittests\": \"da5e3bb127cefea38f2ae247efafe4aef9e06f84\", \"sql_unittests\": \"f1699fe02f74854b724a549fd39ce591fb9a9f2a\", \"storage_unittests\": \"7ccd14ab825608db92a2777576dd507560badc81\", \"ui_android_unittests\": \"af965cea364b69db6e6d80243c4b793ad00bada6\", \"ui_base_unittests\": \"2403dc71a1540a1474bd1ffef55ef329388e4850\", \"ui_touch_selection_unittests\": \"2ff3babbd312a7c4251de9a4998ecba249256edf\", \"unit_tests\": \"9772461c3bd90c771714f7b8c982c83f503065ec\", \"url_unittests\": \"7e883312bd1cef996dd2aa02ce09204109f68466\", \"viz_unittests\": \"652a43dd2f925f910823086ddf94fb76b30d6d9e\", \"vr_android_unittests\": \"a13a37fe344d44fe60bb2e98386d9b0e297a2fde\", \"vr_common_unittests\": \"79d67bf9542852156b00419d1f763ea8e65c3ce9\", \"vr_pixeltests\": \"5ed876df4519d12b92293549fa7751f54f869d49\", \"webview_instrumentation_test_apk\": \"adf15c96f4295dfeee86f18803ad3bde2f55b5ab\", \"wtf_unittests\": \"38df771cc7b5d65e2b32c7c03b0360decc634302\"}}, \"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\": [\"4381-7c1a68d\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**chrome_public_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testCannotSelectPartner\\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#testCannotSelectPartner\\n\\n- org.chromium.chrome.browser.bookmarks.BookmarkReorderTest#testCannotSelectPromo\"}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1563876390628941",
"status": "COMPLETED",
"status_changed_ts": "1563876393253780",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/2087",
"builder:android-code-coverage",
"buildset:commit/git/f38f89947f192f5717195a09d966c4ddef891b78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f38f89947f192f5717195a09d966c4ddef891b78",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072580594006956816",
"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/8907150531684186256/+/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:46371c8daf0c1810",
"user_agent:luci-scheduler"
],
"updated_ts": "1563879791086896",
"url": "https://ci.chromium.org/b/8907150531684186256",
"utcnow_ts": "1563879791594765"
}
}
[11:03:11.609] Invocation finished in 57m45.432776745s with status FAILED