[21:06:08.204] New invocation is queued and will start shortly
[21:06:09.412] Starting the invocation (attempt 1)
[21:06:09.463] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:06:09.463] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:06:09.463] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9074894547472944976",
"parameters_json": "{\"builder_name\":\"android-code-coverage\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"4d3df5234813c269ab48c56115bf17a30fc86344\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-code-coverage",
"scheduler_invocation_id:9074894547472944976",
"scheduler_job_id:chromium/android-code-coverage",
"user_agent:luci-scheduler",
"buildset:commit/git/4d3df5234813c269ab48c56115bf17a30fc86344",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d3df5234813c269ab48c56115bf17a30fc86344",
"gitiles_ref:refs/heads/master"
]
}
[21:06:11.320] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1561669569740085",
"id": "8909464485198183600",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4d3df5234813c269ab48c56115bf17a30fc86344\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1561669571043613",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/1609",
"builder:android-code-coverage",
"buildset:commit/git/4d3df5234813c269ab48c56115bf17a30fc86344",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d3df5234813c269ab48c56115bf17a30fc86344",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074894547472944976",
"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/8909464485198183600/+/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": "1561669571043735",
"url": "https://ci.chromium.org/b/8909464485198183600",
"utcnow_ts": "1561669571295852"
}
}
[21:06:11.320] Task URL: https://ci.chromium.org/b/8909464485198183600
[21:06:11.320] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:2:0) after 1m0s
[21:06:14.822] Received PubSub notification, asking Buildbucket for the build status
[21:06:15.402] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:11.409] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:2:0)
[21:07:11.409] Timer tick, asking Buildbucket for the build status
[21:07:12.139] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:12.140] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:4:0) after 1m0s
[21:08:12.143] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:4:0)
[21:08:12.143] Timer tick, asking Buildbucket for the build status
[21:08:12.798] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:12.798] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:5:0) after 1m0s
[21:09:12.860] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:5:0)
[21:09:12.860] Timer tick, asking Buildbucket for the build status
[21:09:14.224] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:14.224] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:6:0) after 1m0s
[21:10:14.223] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:6:0)
[21:10:14.223] Timer tick, asking Buildbucket for the build status
[21:10:14.656] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:14.656] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:7:0) after 1m0s
[21:11:14.749] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:7:0)
[21:11:14.749] Timer tick, asking Buildbucket for the build status
[21:11:15.890] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:15.890] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:8:0) after 1m0s
[21:12:15.975] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:8:0)
[21:12:15.975] Timer tick, asking Buildbucket for the build status
[21:12:16.294] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:16.294] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:9:0) after 1m0s
[21:13:16.326] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:9:0)
[21:13:16.326] Timer tick, asking Buildbucket for the build status
[21:13:16.457] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:16.457] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:10:0) after 1m0s
[21:14:16.524] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:10:0)
[21:14:16.524] Timer tick, asking Buildbucket for the build status
[21:14:20.266] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:20.266] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:11:0) after 1m0s
[21:15:20.525] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:11:0)
[21:15:20.525] Timer tick, asking Buildbucket for the build status
[21:15:20.730] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:20.730] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:12:0) after 1m0s
[21:16:20.876] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:12:0)
[21:16:20.876] Timer tick, asking Buildbucket for the build status
[21:16:21.032] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:21.032] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:13:0) after 1m0s
[21:17:21.778] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:13:0)
[21:17:21.778] Timer tick, asking Buildbucket for the build status
[21:17:22.340] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:22.340] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:14:0) after 1m0s
[21:18:22.484] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:14:0)
[21:18:22.484] Timer tick, asking Buildbucket for the build status
[21:18:22.812] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:22.812] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:15:0) after 1m0s
[21:19:22.857] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:15:0)
[21:19:22.857] Timer tick, asking Buildbucket for the build status
[21:19:23.413] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:23.413] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:16:0) after 1m0s
[21:20:23.583] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:16:0)
[21:20:23.583] Timer tick, asking Buildbucket for the build status
[21:20:24.385] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:24.385] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:17:0) after 1m0s
[21:21:24.469] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:17:0)
[21:21:24.469] Timer tick, asking Buildbucket for the build status
[21:21:24.573] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:24.573] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:18:0) after 1m0s
[21:22:24.704] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:18:0)
[21:22:24.704] Timer tick, asking Buildbucket for the build status
[21:22:26.148] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:26.148] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:19:0) after 1m0s
[21:23:26.169] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:19:0)
[21:23:26.169] Timer tick, asking Buildbucket for the build status
[21:23:26.565] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:26.565] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:20:0) after 1m0s
[21:24:26.622] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:20:0)
[21:24:26.622] Timer tick, asking Buildbucket for the build status
[21:24:26.890] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:26.890] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:21:0) after 1m0s
[21:25:27.111] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:21:0)
[21:25:27.111] Timer tick, asking Buildbucket for the build status
[21:25:27.855] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:27.855] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:22:0) after 1m0s
[21:26:27.991] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:22:0)
[21:26:27.991] Timer tick, asking Buildbucket for the build status
[21:26:28.360] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:28.360] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:23:0) after 1m0s
[21:27:28.519] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:23:0)
[21:27:28.519] Timer tick, asking Buildbucket for the build status
[21:27:29.521] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:29.521] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:24:0) after 1m0s
[21:28:29.663] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:24:0)
[21:28:29.663] Timer tick, asking Buildbucket for the build status
[21:28:31.081] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:31.081] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:25:0) after 1m0s
[21:29:31.168] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:25:0)
[21:29:31.168] Timer tick, asking Buildbucket for the build status
[21:29:31.753] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:31.753] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:26:0) after 1m0s
[21:30:31.794] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:26:0)
[21:30:31.794] Timer tick, asking Buildbucket for the build status
[21:30:33.535] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:33.535] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:27:0) after 1m0s
[21:31:33.562] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:27:0)
[21:31:33.562] Timer tick, asking Buildbucket for the build status
[21:31:33.836] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:33.836] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:28:0) after 1m0s
[21:32:34.105] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:28:0)
[21:32:34.105] Timer tick, asking Buildbucket for the build status
[21:32:34.266] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:34.266] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:29:0) after 1m0s
[21:33:34.309] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:29:0)
[21:33:34.309] Timer tick, asking Buildbucket for the build status
[21:33:34.732] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:34.732] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:30:0) after 1m0s
[21:34:34.923] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:30:0)
[21:34:34.923] Timer tick, asking Buildbucket for the build status
[21:34:35.152] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:35.152] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:31:0) after 1m0s
[21:35:35.187] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:31:0)
[21:35:35.187] Timer tick, asking Buildbucket for the build status
[21:35:35.515] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:35.515] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:32:0) after 1m0s
[21:36:35.689] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:32:0)
[21:36:35.689] Timer tick, asking Buildbucket for the build status
[21:36:35.860] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:35.860] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:33:0) after 1m0s
[21:37:35.949] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:33:0)
[21:37:35.949] Timer tick, asking Buildbucket for the build status
[21:37:36.254] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:36.254] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:34:0) after 1m0s
[21:38:36.284] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:34:0)
[21:38:36.284] Timer tick, asking Buildbucket for the build status
[21:38:37.550] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:37.550] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:35:0) after 1m0s
[21:39:37.575] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:35:0)
[21:39:37.575] Timer tick, asking Buildbucket for the build status
[21:39:37.688] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:37.688] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:36:0) after 1m0s
[21:40:37.771] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:36:0)
[21:40:37.771] Timer tick, asking Buildbucket for the build status
[21:40:38.097] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:38.097] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:37:0) after 1m0s
[21:41:38.118] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:37:0)
[21:41:38.118] Timer tick, asking Buildbucket for the build status
[21:41:38.557] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:38.557] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:38:0) after 1m0s
[21:42:38.656] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:38:0)
[21:42:38.656] Timer tick, asking Buildbucket for the build status
[21:42:40.790] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:40.790] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:39:0) after 1m0s
[21:43:40.813] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:39:0)
[21:43:40.813] Timer tick, asking Buildbucket for the build status
[21:43:41.106] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:41.106] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:40:0) after 1m0s
[21:44:41.130] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:40:0)
[21:44:41.130] Timer tick, asking Buildbucket for the build status
[21:44:41.301] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:41.301] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:41:0) after 1m0s
[21:45:41.381] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:41:0)
[21:45:41.381] Timer tick, asking Buildbucket for the build status
[21:45:42.298] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:42.298] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:42:0) after 1m0s
[21:46:42.444] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:42:0)
[21:46:42.444] Timer tick, asking Buildbucket for the build status
[21:46:43.063] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:43.063] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:43:0) after 1m0s
[21:47:43.115] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:43:0)
[21:47:43.115] Timer tick, asking Buildbucket for the build status
[21:47:43.322] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:43.322] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:44:0) after 1m0s
[21:48:43.580] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:44:0)
[21:48:43.580] Timer tick, asking Buildbucket for the build status
[21:48:43.828] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:43.828] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:45:0) after 1m0s
[21:49:43.911] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:45:0)
[21:49:43.911] Timer tick, asking Buildbucket for the build status
[21:49:44.882] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:44.882] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:46:0) after 1m0s
[21:50:44.948] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:46:0)
[21:50:44.948] Timer tick, asking Buildbucket for the build status
[21:50:45.206] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:45.206] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:47:0) after 1m0s
[21:51:45.270] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:47:0)
[21:51:45.270] Timer tick, asking Buildbucket for the build status
[21:51:47.105] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:47.105] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:48:0) after 1m0s
[21:52:47.126] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:48:0)
[21:52:47.126] Timer tick, asking Buildbucket for the build status
[21:52:47.422] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:47.422] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:49:0) after 1m0s
[21:53:47.490] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:49:0)
[21:53:47.490] Timer tick, asking Buildbucket for the build status
[21:53:47.943] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:47.943] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:50:0) after 1m0s
[21:54:47.965] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:50:0)
[21:54:47.965] Timer tick, asking Buildbucket for the build status
[21:54:49.217] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:49.217] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:51:0) after 1m0s
[21:55:49.258] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:51:0)
[21:55:49.258] Timer tick, asking Buildbucket for the build status
[21:55:49.478] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:49.478] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:52:0) after 1m0s
[21:56:49.554] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:52:0)
[21:56:49.554] Timer tick, asking Buildbucket for the build status
[21:56:49.850] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:49.850] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:53:0) after 1m0s
[21:57:49.908] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:53:0)
[21:57:49.908] Timer tick, asking Buildbucket for the build status
[21:57:50.078] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:50.078] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:54:0) after 1m0s
[21:58:50.110] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:54:0)
[21:58:50.110] Timer tick, asking Buildbucket for the build status
[21:58:50.987] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:50.987] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:55:0) after 1m0s
[21:59:50.985] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:55:0)
[21:59:50.985] Timer tick, asking Buildbucket for the build status
[21:59:51.353] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:51.353] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:56:0) after 1m0s
[22:00:51.473] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:56:0)
[22:00:51.473] Timer tick, asking Buildbucket for the build status
[22:00:52.664] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:52.664] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:57:0) after 1m0s
[22:01:52.708] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:57:0)
[22:01:52.708] Timer tick, asking Buildbucket for the build status
[22:01:54.360] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:54.360] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:58:0) after 1m0s
[22:02:54.445] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:58:0)
[22:02:54.445] Timer tick, asking Buildbucket for the build status
[22:02:54.590] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:54.590] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:59:0) after 1m0s
[22:03:54.615] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:59:0)
[22:03:54.615] Timer tick, asking Buildbucket for the build status
[22:03:54.758] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:54.758] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:60:0) after 1m0s
[22:04:54.801] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:60:0)
[22:04:54.801] Timer tick, asking Buildbucket for the build status
[22:04:55.596] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:55.596] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:61:0) after 1m0s
[22:05:55.647] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:61:0)
[22:05:55.647] Timer tick, asking Buildbucket for the build status
[22:05:56.517] Build 8909464485198183600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:56.517] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage:9074894547472944976:62:0) after 1m0s
[22:05:59.831] Received PubSub notification, asking Buildbucket for the build status
[22:05:59.932] Build 8909464485198183600: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:05:59.932] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1561673157824608",
"created_by": "project:chromium",
"created_ts": "1561669569740085",
"failure_reason": "BUILD_FAILURE",
"id": "8909464485198183600",
"parameters_json": "{\"builder_name\": \"android-code-coverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4d3df5234813c269ab48c56115bf17a30fc86344\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 tests failed: ['network_service_out_of_process_chrome_public_test_apk on Android device Nexus 5X']\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"android-code-coverage-0-5qck\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-code-coverage\", \"buildnumber\": 1609, \"got_angle_revision\": \"485cdd8bd3db3b83776a83a89154771a6983cc99\", \"got_dawn_revision\": \"eee3e41c554257a0ece66e70b2b4e1390ffa6ab0\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"4d3df5234813c269ab48c56115bf17a30fc86344\", \"got_revision_cp\": \"refs/heads/master@{#673061}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"120409a92a159b20b52fb55de193d1723ca0f2b5\", \"got_v8_revision_cp\": \"refs/heads/7.7.155@{#1}\", \"got_webrtc_revision\": \"c2f56862a607c75ae35e36410aaf3df5d1befca7\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28402}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"4d3df5234813c269ab48c56115bf17a30fc86344\", \"swarm_hashes\": {\"android_webview_unittests\": \"f6df6320189b4d772c613375c62c902431e57c67\", \"angle_unittests\": \"928ec656938eea4c66a83b1379ab30994221eaa3\", \"base_unittests\": \"eec859cec026a5f2137b42dcb58e1c6f57475550\", \"base_util_unittests\": \"97cf5075ca15da9570d8be8bf2217d98b38194af\", \"blink_common_unittests\": \"f8ea3701d6d03f7b6082b8c6e53ee4b0f3a7d298\", \"blink_heap_unittests\": \"d9e912510dab9ffccdc24131c3714e3e3bbd62f6\", \"blink_platform_unittests\": \"0878bb238f2a917cb901c909d447bd8ee7cf3f0c\", \"blink_unittests\": \"8424f756543bdf39b52864e1163c39f4f8c41863\", \"boringssl_crypto_tests\": \"7e345a057e58ecb98468912e28ed82c3bcd758d1\", \"boringssl_ssl_tests\": \"1b8fdfe848fe105dbcf314e949f58d18e5708d50\", \"breakpad_unittests\": \"485e442f6007348df3739e4b3532b2668004f8f8\", \"cacheinvalidation_unittests\": \"3b58051956a0c57d796d2e769cde78f4eec92767\", \"capture_unittests\": \"e71ca7ce98269f1183d95e25c0b577feb03280b7\", \"cast_unittests\": \"db5f7c7d9390be42e731b3bdf47befd4cabaf21c\", \"cc_unittests\": \"af73cca3c5703356c58f4ce07cbf00d6b6dcc000\", \"chrome_public_test_apk\": \"635ecec8e06f8e49e3cc82f5e266d9c811ab4aae\", \"chrome_public_test_vr_apk\": \"0fbfbd3124e15aa2f37043b500785b0a83c16b37\", \"components_browsertests\": \"ca2e242b821722ee1210a45662d69e3e19c31b3a\", \"components_unittests\": \"f99aacb4ffa96f4931adfcfae1dfe3438e29bf93\", \"content_browsertests\": \"51eac163834d415c22a28397b5912997c473c817\", \"content_shell_test_apk\": \"672b44e6f07a73b0dec362370ca0a6cb34416640\", \"content_unittests\": \"b06b8957da4d98b2d751a3c6f9a1cbc5c45ffdcb\", \"crypto_unittests\": \"8f5008d83d047c17fe58f8d14d90ef18c8567a2c\", \"device_unittests\": \"b2c15ca783694871db1dcf8f95638911d969ee3f\", \"display_unittests\": \"caaae92039fc3512f165a697d816a84581a3fdc5\", \"events_unittests\": \"5cff6a478d163313f7d0609c0eae5815abe26ea2\", \"gcm_unit_tests\": \"01f954a03199a21fa281a41deb96d78e4e23c045\", \"gfx_unittests\": \"dd9b1780d448256cc7cf9a82d3cca1e451c13a45\", \"gin_unittests\": \"ff64b28aab4e347b855dce66cf013f955319923f\", \"gl_tests\": \"beea479c88da28dbcc3ab4170c0bda63d74e4707\", \"gl_unittests\": \"703652c28ff64e1ecc7351e3ad1c44920b9f8d46\", \"google_apis_unittests\": \"121a125ff7056dbfc9f74f3e9fbc630ea2784cfa\", \"gpu_unittests\": \"7da54b207e4abde4b6519ca28ab0e1e9a2d3eeac\", \"ipc_tests\": \"341dacd762e940a3f9a518783a764f17afcc6914\", \"jingle_unittests\": \"6a36c94393c12f3ea0c9c39b39acb79ce5bedc35\", \"latency_unittests\": \"7e8fc5a0b08b47227f6d1c4ef5b0c08fcd9228d0\", \"libjingle_xmpp_unittests\": \"6aff71a836db9251b3ad429f78b24465b8af5553\", \"media_blink_unittests\": \"030dec40aa89296ae17828c4a5e5bb791e65b1d7\", \"media_service_unittests\": \"043bbf376c8fe60701527d7f302aefca970273f5\", \"media_unittests\": \"c4224d024601e3d2fb26db0547c80d908f6f6add\", \"midi_unittests\": \"bfeea942c367081bbbaa0c88a52dbbf802158a52\", \"mojo_test_apk\": \"9ff1aec6d418e4df451883419b0131c98daaa361\", \"mojo_unittests\": \"a09d1f9d9c243978832f590abe45cf543324276b\", \"net_unittests\": \"2e5015ea0c167bfcac8e4ba3172bd6ecd90b6c76\", \"sandbox_linux_unittests\": \"1a99a127197a22afa8c5562bf8107cb78305dc53\", \"services_unittests\": \"1414fa2dbff14880074bbb5aa752ead89f4a8110\", \"shell_dialogs_unittests\": \"9089d449234aa1f77d73dd24adc3b45d4cfbc1a1\", \"skia_unittests\": \"64dd078eb8bb8c71a31dcec9e64082c0d7a98daa\", \"sql_unittests\": \"64ea3094483662b8f1abe978ceb08a78d48bb8a0\", \"storage_unittests\": \"10a2310077a3b890ccb55586a5f17bc53eeb1d78\", \"ui_android_unittests\": \"09489a8084ca507a1eb80754c04bcd14ba5d0d11\", \"ui_base_unittests\": \"058d7afd54103c2b1a637d1d19ea2642d2a45b9a\", \"ui_touch_selection_unittests\": \"994100df74224da4e10a3620e923ca99d3381d42\", \"unit_tests\": \"c1c5862ea8634f702403d377f02ebdbd413d9603\", \"url_unittests\": \"4c38bc25b449cfc54918d7083e31dd6dbf410a2e\", \"viz_unittests\": \"8c9d6c81dfafe0f8e7add7de9c8c0810fc25f155\", \"vr_android_unittests\": \"c75d4b5c63915158551bede939c86d64fc418143\", \"vr_common_unittests\": \"a3531f54e565471ef11cde48b69cdb4c81726431\", \"vr_pixeltests\": \"be27a97eb940a4b5fa6876921283eb74ceb0d9ae\", \"webview_instrumentation_test_apk\": \"416b32bfae58645dc0f930e9f9e3ea72fdb45500\", \"wtf_unittests\": \"3b1ac0b9cfaa3dd20ab498656522d08ce3a3bef5\"}, \"swarm_hashes_refs/heads/master(at){#673061}_without_patch\": {\"android_webview_unittests\": \"f6df6320189b4d772c613375c62c902431e57c67\", \"angle_unittests\": \"928ec656938eea4c66a83b1379ab30994221eaa3\", \"base_unittests\": \"eec859cec026a5f2137b42dcb58e1c6f57475550\", \"base_util_unittests\": \"97cf5075ca15da9570d8be8bf2217d98b38194af\", \"blink_common_unittests\": \"f8ea3701d6d03f7b6082b8c6e53ee4b0f3a7d298\", \"blink_heap_unittests\": \"d9e912510dab9ffccdc24131c3714e3e3bbd62f6\", \"blink_platform_unittests\": \"0878bb238f2a917cb901c909d447bd8ee7cf3f0c\", \"blink_unittests\": \"8424f756543bdf39b52864e1163c39f4f8c41863\", \"boringssl_crypto_tests\": \"7e345a057e58ecb98468912e28ed82c3bcd758d1\", \"boringssl_ssl_tests\": \"1b8fdfe848fe105dbcf314e949f58d18e5708d50\", \"breakpad_unittests\": \"485e442f6007348df3739e4b3532b2668004f8f8\", \"cacheinvalidation_unittests\": \"3b58051956a0c57d796d2e769cde78f4eec92767\", \"capture_unittests\": \"e71ca7ce98269f1183d95e25c0b577feb03280b7\", \"cast_unittests\": \"db5f7c7d9390be42e731b3bdf47befd4cabaf21c\", \"cc_unittests\": \"af73cca3c5703356c58f4ce07cbf00d6b6dcc000\", \"chrome_public_test_apk\": \"635ecec8e06f8e49e3cc82f5e266d9c811ab4aae\", \"chrome_public_test_vr_apk\": \"0fbfbd3124e15aa2f37043b500785b0a83c16b37\", \"components_browsertests\": \"ca2e242b821722ee1210a45662d69e3e19c31b3a\", \"components_unittests\": \"f99aacb4ffa96f4931adfcfae1dfe3438e29bf93\", \"content_browsertests\": \"51eac163834d415c22a28397b5912997c473c817\", \"content_shell_test_apk\": \"672b44e6f07a73b0dec362370ca0a6cb34416640\", \"content_unittests\": \"b06b8957da4d98b2d751a3c6f9a1cbc5c45ffdcb\", \"crypto_unittests\": \"8f5008d83d047c17fe58f8d14d90ef18c8567a2c\", \"device_unittests\": \"b2c15ca783694871db1dcf8f95638911d969ee3f\", \"display_unittests\": \"caaae92039fc3512f165a697d816a84581a3fdc5\", \"events_unittests\": \"5cff6a478d163313f7d0609c0eae5815abe26ea2\", \"gcm_unit_tests\": \"01f954a03199a21fa281a41deb96d78e4e23c045\", \"gfx_unittests\": \"dd9b1780d448256cc7cf9a82d3cca1e451c13a45\", \"gin_unittests\": \"ff64b28aab4e347b855dce66cf013f955319923f\", \"gl_tests\": \"beea479c88da28dbcc3ab4170c0bda63d74e4707\", \"gl_unittests\": \"703652c28ff64e1ecc7351e3ad1c44920b9f8d46\", \"google_apis_unittests\": \"121a125ff7056dbfc9f74f3e9fbc630ea2784cfa\", \"gpu_unittests\": \"7da54b207e4abde4b6519ca28ab0e1e9a2d3eeac\", \"ipc_tests\": \"341dacd762e940a3f9a518783a764f17afcc6914\", \"jingle_unittests\": \"6a36c94393c12f3ea0c9c39b39acb79ce5bedc35\", \"latency_unittests\": \"7e8fc5a0b08b47227f6d1c4ef5b0c08fcd9228d0\", \"libjingle_xmpp_unittests\": \"6aff71a836db9251b3ad429f78b24465b8af5553\", \"media_blink_unittests\": \"030dec40aa89296ae17828c4a5e5bb791e65b1d7\", \"media_service_unittests\": \"043bbf376c8fe60701527d7f302aefca970273f5\", \"media_unittests\": \"c4224d024601e3d2fb26db0547c80d908f6f6add\", \"midi_unittests\": \"bfeea942c367081bbbaa0c88a52dbbf802158a52\", \"mojo_test_apk\": \"9ff1aec6d418e4df451883419b0131c98daaa361\", \"mojo_unittests\": \"a09d1f9d9c243978832f590abe45cf543324276b\", \"net_unittests\": \"2e5015ea0c167bfcac8e4ba3172bd6ecd90b6c76\", \"sandbox_linux_unittests\": \"1a99a127197a22afa8c5562bf8107cb78305dc53\", \"services_unittests\": \"1414fa2dbff14880074bbb5aa752ead89f4a8110\", \"shell_dialogs_unittests\": \"9089d449234aa1f77d73dd24adc3b45d4cfbc1a1\", \"skia_unittests\": \"64dd078eb8bb8c71a31dcec9e64082c0d7a98daa\", \"sql_unittests\": \"64ea3094483662b8f1abe978ceb08a78d48bb8a0\", \"storage_unittests\": \"10a2310077a3b890ccb55586a5f17bc53eeb1d78\", \"ui_android_unittests\": \"09489a8084ca507a1eb80754c04bcd14ba5d0d11\", \"ui_base_unittests\": \"058d7afd54103c2b1a637d1d19ea2642d2a45b9a\", \"ui_touch_selection_unittests\": \"994100df74224da4e10a3620e923ca99d3381d42\", \"unit_tests\": \"c1c5862ea8634f702403d377f02ebdbd413d9603\", \"url_unittests\": \"4c38bc25b449cfc54918d7083e31dd6dbf410a2e\", \"viz_unittests\": \"8c9d6c81dfafe0f8e7add7de9c8c0810fc25f155\", \"vr_android_unittests\": \"c75d4b5c63915158551bede939c86d64fc418143\", \"vr_common_unittests\": \"a3531f54e565471ef11cde48b69cdb4c81726431\", \"vr_pixeltests\": \"be27a97eb940a4b5fa6876921283eb74ceb0d9ae\", \"webview_instrumentation_test_apk\": \"416b32bfae58645dc0f930e9f9e3ea72fdb45500\", \"wtf_unittests\": \"3b1ac0b9cfaa3dd20ab498656522d08ce3a3bef5\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"android-code-coverage\"], \"caches\": [\"builder_f2ac5903ab08ee4ddab389becac92d3a3647f6b791038f1abef5b06a03e08513_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"android-code-coverage-0-5qck\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-highmem-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4351-b85b41c\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 tests failed: ['network_service_out_of_process_chrome_public_test_apk on Android device Nexus 5X']\"}}",
"service_account": "chromium-code-coverage-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1561669574042920",
"status": "COMPLETED",
"status_changed_ts": "1561669574428101",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage/1609",
"builder:android-code-coverage",
"buildset:commit/git/4d3df5234813c269ab48c56115bf17a30fc86344",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4d3df5234813c269ab48c56115bf17a30fc86344",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074894547472944976",
"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/8909464485198183600/+/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:45b3941c320abf10",
"user_agent:luci-scheduler"
],
"updated_ts": "1561673158599936",
"url": "https://ci.chromium.org/b/8909464485198183600",
"utcnow_ts": "1561673159925326"
}
}
[22:05:59.932] Invocation finished in 59m51.744821982s with status FAILED