[17:31:46.391] New invocation is queued and will start shortly
[17:31:47.635] Starting the invocation (attempt 1)
[17:31:47.692] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:31:47.692] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:31:47.692] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059868937640948912",
"parameters_json": "{\"builder_name\":\"android-code-coverage-native\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"72bbbb91f7f5ca666ef2450dd972e522281694ed\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-code-coverage-native",
"scheduler_invocation_id:9059868937640948912",
"scheduler_job_id:chromium/android-code-coverage-native",
"user_agent:luci-scheduler",
"buildset:commit/git/72bbbb91f7f5ca666ef2450dd972e522281694ed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/72bbbb91f7f5ca666ef2450dd972e522281694ed",
"gitiles_ref:refs/heads/master"
]
}
[17:31:48.763] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575999107945440",
"id": "8894438875345635552",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"72bbbb91f7f5ca666ef2450dd972e522281694ed\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575999108612421",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/2916",
"builder:android-code-coverage-native",
"buildset:commit/git/72bbbb91f7f5ca666ef2450dd972e522281694ed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/72bbbb91f7f5ca666ef2450dd972e522281694ed",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059868937640948912",
"scheduler_job_id:chromium/android-code-coverage-native",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8894438875345635552/+/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": "1575999108612559",
"url": "https://ci.chromium.org/b/8894438875345635552",
"utcnow_ts": "1575999108753473"
}
}
[17:31:48.763] Task URL: https://ci.chromium.org/b/8894438875345635552
[17:31:48.763] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:2:0) after 1m0s
[17:32:44.292] Received PubSub notification, asking Buildbucket for the build status
[17:32:44.669] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:48.817] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:2:0)
[17:32:48.817] Timer tick, asking Buildbucket for the build status
[17:32:49.430] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:49.430] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:4:0) after 1m0s
[17:33:49.495] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:4:0)
[17:33:49.495] Timer tick, asking Buildbucket for the build status
[17:33:50.396] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:50.396] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:5:0) after 1m0s
[17:34:50.470] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:5:0)
[17:34:50.470] Timer tick, asking Buildbucket for the build status
[17:34:50.810] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:50.810] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:6:0) after 1m0s
[17:35:50.844] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:6:0)
[17:35:50.844] Timer tick, asking Buildbucket for the build status
[17:35:51.050] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:51.050] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:7:0) after 1m0s
[17:36:51.169] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:7:0)
[17:36:51.169] Timer tick, asking Buildbucket for the build status
[17:36:51.539] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:51.539] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:8:0) after 1m0s
[17:37:51.625] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:8:0)
[17:37:51.625] Timer tick, asking Buildbucket for the build status
[17:37:51.875] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:51.875] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:9:0) after 1m0s
[17:38:52.045] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:9:0)
[17:38:52.045] Timer tick, asking Buildbucket for the build status
[17:38:52.229] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:52.229] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:10:0) after 1m0s
[17:39:52.342] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:10:0)
[17:39:52.342] Timer tick, asking Buildbucket for the build status
[17:39:52.762] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:52.762] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:11:0) after 1m0s
[17:40:52.893] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:11:0)
[17:40:52.893] Timer tick, asking Buildbucket for the build status
[17:40:53.074] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:53.074] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:12:0) after 1m0s
[17:41:53.123] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:12:0)
[17:41:53.123] Timer tick, asking Buildbucket for the build status
[17:41:53.662] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:53.662] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:13:0) after 1m0s
[17:42:53.712] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:13:0)
[17:42:53.712] Timer tick, asking Buildbucket for the build status
[17:42:53.897] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:53.897] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:14:0) after 1m0s
[17:43:53.959] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:14:0)
[17:43:53.959] Timer tick, asking Buildbucket for the build status
[17:43:54.620] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:54.620] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:15:0) after 1m0s
[17:44:54.746] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:15:0)
[17:44:54.746] Timer tick, asking Buildbucket for the build status
[17:44:54.875] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:54.875] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:16:0) after 1m0s
[17:45:55.024] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:16:0)
[17:45:55.024] Timer tick, asking Buildbucket for the build status
[17:45:55.237] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:55.237] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:17:0) after 1m0s
[17:46:55.305] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:17:0)
[17:46:55.305] Timer tick, asking Buildbucket for the build status
[17:46:56.016] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:56.016] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:18:0) after 1m0s
[17:47:56.043] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:18:0)
[17:47:56.043] Timer tick, asking Buildbucket for the build status
[17:47:56.328] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:56.328] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:19:0) after 1m0s
[17:48:56.396] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:19:0)
[17:48:56.396] Timer tick, asking Buildbucket for the build status
[17:48:56.689] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:56.689] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:20:0) after 1m0s
[17:49:56.781] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:20:0)
[17:49:56.781] Timer tick, asking Buildbucket for the build status
[17:49:57.790] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:57.790] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:21:0) after 1m0s
[17:50:57.828] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:21:0)
[17:50:57.828] Timer tick, asking Buildbucket for the build status
[17:50:58.173] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:58.173] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:22:0) after 1m0s
[17:51:58.213] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:22:0)
[17:51:58.213] Timer tick, asking Buildbucket for the build status
[17:51:58.953] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:58.953] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:23:0) after 1m0s
[17:52:58.980] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:23:0)
[17:52:58.980] Timer tick, asking Buildbucket for the build status
[17:52:59.492] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:59.492] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:24:0) after 1m0s
[17:53:59.520] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:24:0)
[17:53:59.520] Timer tick, asking Buildbucket for the build status
[17:53:59.778] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:59.778] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:25:0) after 1m0s
[17:54:59.839] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:25:0)
[17:54:59.839] Timer tick, asking Buildbucket for the build status
[17:55:00.074] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:00.074] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:26:0) after 1m0s
[17:56:00.142] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:26:0)
[17:56:00.142] Timer tick, asking Buildbucket for the build status
[17:56:02.011] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:02.011] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:27:0) after 1m0s
[17:57:02.012] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:27:0)
[17:57:02.012] Timer tick, asking Buildbucket for the build status
[17:57:02.175] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:02.175] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:28:0) after 1m0s
[17:58:02.221] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:28:0)
[17:58:02.221] Timer tick, asking Buildbucket for the build status
[17:58:02.384] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:02.384] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:29:0) after 1m0s
[17:59:02.444] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:29:0)
[17:59:02.444] Timer tick, asking Buildbucket for the build status
[17:59:03.000] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:03.000] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:30:0) after 1m0s
[18:00:03.049] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:30:0)
[18:00:03.049] Timer tick, asking Buildbucket for the build status
[18:00:03.574] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:03.574] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:31:0) after 1m0s
[18:01:03.626] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:31:0)
[18:01:03.626] Timer tick, asking Buildbucket for the build status
[18:01:04.317] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:04.317] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:32:0) after 1m0s
[18:02:04.387] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:32:0)
[18:02:04.387] Timer tick, asking Buildbucket for the build status
[18:02:04.843] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:04.843] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:33:0) after 1m0s
[18:03:04.878] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:33:0)
[18:03:04.878] Timer tick, asking Buildbucket for the build status
[18:03:05.212] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:05.212] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:34:0) after 1m0s
[18:04:05.212] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:34:0)
[18:04:05.212] Timer tick, asking Buildbucket for the build status
[18:04:05.476] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:05.476] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:35:0) after 1m0s
[18:05:05.574] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:35:0)
[18:05:05.574] Timer tick, asking Buildbucket for the build status
[18:05:05.766] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:05.766] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:36:0) after 1m0s
[18:06:05.831] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:36:0)
[18:06:05.831] Timer tick, asking Buildbucket for the build status
[18:06:06.191] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:06.191] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:37:0) after 1m0s
[18:07:06.262] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:37:0)
[18:07:06.262] Timer tick, asking Buildbucket for the build status
[18:07:08.092] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:08.092] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:38:0) after 1m0s
[18:08:08.174] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:38:0)
[18:08:08.174] Timer tick, asking Buildbucket for the build status
[18:08:08.484] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:08.484] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:39:0) after 1m0s
[18:09:08.532] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:39:0)
[18:09:08.532] Timer tick, asking Buildbucket for the build status
[18:09:08.708] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:08.708] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:40:0) after 1m0s
[18:10:08.733] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:40:0)
[18:10:08.733] Timer tick, asking Buildbucket for the build status
[18:10:08.951] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:08.951] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:41:0) after 1m0s
[18:11:09.022] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:41:0)
[18:11:09.022] Timer tick, asking Buildbucket for the build status
[18:11:09.602] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:09.602] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:42:0) after 1m0s
[18:12:09.657] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:42:0)
[18:12:09.657] Timer tick, asking Buildbucket for the build status
[18:12:10.083] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:10.083] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:43:0) after 1m0s
[18:13:10.173] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:43:0)
[18:13:10.174] Timer tick, asking Buildbucket for the build status
[18:13:12.157] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:12.157] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:44:0) after 1m0s
[18:14:12.239] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:44:0)
[18:14:12.239] Timer tick, asking Buildbucket for the build status
[18:14:12.534] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:12.534] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:45:0) after 1m0s
[18:15:12.640] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:45:0)
[18:15:12.640] Timer tick, asking Buildbucket for the build status
[18:15:12.849] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:12.849] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:46:0) after 1m0s
[18:16:12.893] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:46:0)
[18:16:12.893] Timer tick, asking Buildbucket for the build status
[18:16:13.088] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:13.088] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:47:0) after 1m0s
[18:17:13.169] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:47:0)
[18:17:13.169] Timer tick, asking Buildbucket for the build status
[18:17:13.360] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:13.360] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:48:0) after 1m0s
[18:18:13.704] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:48:0)
[18:18:13.704] Timer tick, asking Buildbucket for the build status
[18:18:13.876] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:13.876] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:49:0) after 1m0s
[18:19:14.246] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:49:0)
[18:19:14.246] Timer tick, asking Buildbucket for the build status
[18:19:14.607] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:14.607] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:50:0) after 1m0s
[18:20:14.765] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:50:0)
[18:20:14.765] Timer tick, asking Buildbucket for the build status
[18:20:16.133] Build 8894438875345635552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:16.134] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059868937640948912:51:0) after 1m0s
[18:20:33.881] Received PubSub notification, asking Buildbucket for the build status
[18:20:34.824] Build 8894438875345635552: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:20:34.824] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576002033318477",
"created_by": "project:chromium",
"created_ts": "1575999107945440",
"failure_reason": "BUILD_FAILURE",
"id": "8894438875345635552",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"72bbbb91f7f5ca666ef2450dd972e522281694ed\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('process clang code coverage data.generate metadata for 49 tests') (retcode: 1)\"}, \"properties\": {\"$build/code_coverage\": {\"use_clang_coverage\": true}, \"$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-my8f\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-code-coverage-native\", \"buildnumber\": 2916, \"coverage_gs_bucket\": \"code-coverage-data\", \"coverage_is_presubmit\": false, \"coverage_metadata_gs_path\": \"postsubmit/chromium.googlesource.com/chromium/src/72bbbb91f7f5ca666ef2450dd972e522281694ed/ci/android-code-coverage-native/8894438875345635552/metadata\", \"got_angle_revision\": \"f60da87424a4747142d3f7187a55c1e19869a663\", \"got_dawn_revision\": \"ff8b3f43972342de3ea48cb94c036d8a7b7089c5\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"72bbbb91f7f5ca666ef2450dd972e522281694ed\", \"got_revision_cp\": \"refs/heads/master@{#723395}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"bb7c3388a50c012123e82491975576bee48a4300\", \"got_v8_revision\": \"3f57d6f93a15b221fe92cd34e87482f3c39df122\", \"got_v8_revision_cp\": \"refs/heads/8.1.11@{#1}\", \"got_webrtc_revision\": \"ded86c1ad80b1f68ffdca2fdddcb4545a6b02ce6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30050}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"merged_profdata_gs_path\": \"postsubmit/chromium.googlesource.com/chromium/src/72bbbb91f7f5ca666ef2450dd972e522281694ed/ci/android-code-coverage-native/8894438875345635552/merged.profdata\", \"path_config\": \"generic\", \"process_coverage_data_failure\": true, \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"72bbbb91f7f5ca666ef2450dd972e522281694ed\", \"swarm_hashes\": {\"android_browsertests\": \"67ef01da0114102b35bd1c5040581b1c4c2e6ae4\", \"angle_unittests\": \"3c44f2fd7176707c840f9ecbf056b94bdbf6c255\", \"base_unittests\": \"bcb058e8fdde868ecc776fd0e774b9846aecb697\", \"base_util_unittests\": \"7453a5e3945c2a49d3a993aadd5ff349bdf1e997\", \"blink_common_unittests\": \"2da9f8dc5aa1dfb1798e699b9f9e85607710f79e\", \"blink_heap_unittests\": \"ff459dea27bc8c9f3e42c2026f53772104c9fa2d\", \"blink_platform_unittests\": \"3c7a8c7453dd41ccf8bce9cf5d3319d716b7cc47\", \"boringssl_crypto_tests\": \"7bc9f148a9f7e1730e10e831f2f7e7c2d61375c2\", \"boringssl_ssl_tests\": \"e80e0ceab4f64e979f56fff5f60014fcf98ffb2e\", \"breakpad_unittests\": \"a0923eea4ca3362f22e4cb625d2175ba9bfaf8dc\", \"cacheinvalidation_unittests\": \"5a688e8a2bd341684d2ea635a78dd1934315ad8d\", \"capture_unittests\": \"3b09170677261ee22f5dcf704676a748795eb0b9\", \"cast_unittests\": \"54a1ee4bbfb8b983730fcfa61f69058251dc3d70\", \"cc_unittests\": \"de607fc18b366b8d8f068d29ae1fc170c76de2b9\", \"crypto_unittests\": \"598e53ef50efa21913ebd6c7d1eaf54f9b064ed9\", \"device_unittests\": \"b1174bbaeb34d2bc0318e23643d9929c91e0e45d\", \"display_unittests\": \"8632e1eddae18adaa65b098396d6b4b8eff31c99\", \"events_unittests\": \"94536fd4b4889f49b0494520561bfa973c88fd36\", \"gcm_unit_tests\": \"7c8609980284a2cda266f34e36ab5a120009dca2\", \"gfx_unittests\": \"38faa259f83dde5fed15eb24e5a7ceff345c875b\", \"gin_unittests\": \"89bf296bcb4fe58e45c461d8309a7596521b890c\", \"gl_tests\": \"073f3ca3a6e4b5cae14482f99dfc25582488e58b\", \"gl_unittests\": \"351eb4f79f23d4a7b814184a50ce85ab1478e586\", \"google_apis_unittests\": \"e91dcecaee822e056b8624e4274f0bf8e49744eb\", \"gpu_unittests\": \"29ad24f2be614375755d8ff99b20c2370e538c55\", \"gwp_asan_unittests\": \"7dd27b455c60352f9f13ccb8732524a5c470f17c\", \"ipc_tests\": \"86d66b2e9fa460aa6cfd1f2f01133be527b4ef62\", \"jingle_unittests\": \"1190faa21c77830d692919af6cd0fe40ebb304f6\", \"latency_unittests\": \"a81e174b673e751b83d2197980d85837bcc54a9f\", \"libjingle_xmpp_unittests\": \"4cd38cfdabd930e9231cbc62f32d4716c17f07e9\", \"media_blink_unittests\": \"754d14d0e51d27c28f02c5b7793ac4be9f919f3e\", \"media_service_unittests\": \"9acc04572ef09f3a60ca0195ce309feac397a14b\", \"media_unittests\": \"9ae59dfc4779ebbfaa5f33b0242cfbc0145bd995\", \"midi_unittests\": \"70f36975a5e2f4148a42932fa298e77b65383870\", \"mojo_test_apk\": \"cef8152f5eec69258bacfb5b098ac34691d736ab\", \"mojo_unittests\": \"2f374cfa887db644f17b4484e6420b8ae18e9860\", \"net_unittests\": \"d670bf1f8d0c7f08757c07846478a00f014dd758\", \"sandbox_linux_unittests\": \"c5289bc80e8d33c9100c274106c4da96d30ada71\", \"services_unittests\": \"7406ed616bba3fae8bd155ddb51ee2ea97f12432\", \"shell_dialogs_unittests\": \"f3a9cdb1572743431920e1b944883d8fbfc5557c\", \"skia_unittests\": \"6de25a378c0909afd6b27cba27030b383f5ca858\", \"sql_unittests\": \"50debddc911c7d50d3869df3c48ebb6a4445c390\", \"storage_unittests\": \"7627ae25880f71cf48d4e8be65cc290605c3cf3a\", \"ui_android_unittests\": \"fbd3fe106f60ec44a5a50ac7cf99f1541e58daa2\", \"ui_base_unittests\": \"0c9d38bf6da6ba2451540e0557e3d26dad51d1a5\", \"ui_touch_selection_unittests\": \"4073c521706a18e2598022b67af17fed3e221215\", \"url_unittests\": \"1d5f7e7ffbced0126a2211cfa95741f533c9ee33\", \"viz_unittests\": \"288cd50a02c83e04506d8e02256f066eb6f12745\", \"wtf_unittests\": \"6233529ac9a092a36eb0d308a6999af8f3cb71fa\"}, \"swarm_hashes_refs/heads/master(at){#723395}_without_patch\": {\"android_browsertests\": \"67ef01da0114102b35bd1c5040581b1c4c2e6ae4\", \"angle_unittests\": \"3c44f2fd7176707c840f9ecbf056b94bdbf6c255\", \"base_unittests\": \"bcb058e8fdde868ecc776fd0e774b9846aecb697\", \"base_util_unittests\": \"7453a5e3945c2a49d3a993aadd5ff349bdf1e997\", \"blink_common_unittests\": \"2da9f8dc5aa1dfb1798e699b9f9e85607710f79e\", \"blink_heap_unittests\": \"ff459dea27bc8c9f3e42c2026f53772104c9fa2d\", \"blink_platform_unittests\": \"3c7a8c7453dd41ccf8bce9cf5d3319d716b7cc47\", \"boringssl_crypto_tests\": \"7bc9f148a9f7e1730e10e831f2f7e7c2d61375c2\", \"boringssl_ssl_tests\": \"e80e0ceab4f64e979f56fff5f60014fcf98ffb2e\", \"breakpad_unittests\": \"a0923eea4ca3362f22e4cb625d2175ba9bfaf8dc\", \"cacheinvalidation_unittests\": \"5a688e8a2bd341684d2ea635a78dd1934315ad8d\", \"capture_unittests\": \"3b09170677261ee22f5dcf704676a748795eb0b9\", \"cast_unittests\": \"54a1ee4bbfb8b983730fcfa61f69058251dc3d70\", \"cc_unittests\": \"de607fc18b366b8d8f068d29ae1fc170c76de2b9\", \"crypto_unittests\": \"598e53ef50efa21913ebd6c7d1eaf54f9b064ed9\", \"device_unittests\": \"b1174bbaeb34d2bc0318e23643d9929c91e0e45d\", \"display_unittests\": \"8632e1eddae18adaa65b098396d6b4b8eff31c99\", \"events_unittests\": \"94536fd4b4889f49b0494520561bfa973c88fd36\", \"gcm_unit_tests\": \"7c8609980284a2cda266f34e36ab5a120009dca2\", \"gfx_unittests\": \"38faa259f83dde5fed15eb24e5a7ceff345c875b\", \"gin_unittests\": \"89bf296bcb4fe58e45c461d8309a7596521b890c\", \"gl_tests\": \"073f3ca3a6e4b5cae14482f99dfc25582488e58b\", \"gl_unittests\": \"351eb4f79f23d4a7b814184a50ce85ab1478e586\", \"google_apis_unittests\": \"e91dcecaee822e056b8624e4274f0bf8e49744eb\", \"gpu_unittests\": \"29ad24f2be614375755d8ff99b20c2370e538c55\", \"gwp_asan_unittests\": \"7dd27b455c60352f9f13ccb8732524a5c470f17c\", \"ipc_tests\": \"86d66b2e9fa460aa6cfd1f2f01133be527b4ef62\", \"jingle_unittests\": \"1190faa21c77830d692919af6cd0fe40ebb304f6\", \"latency_unittests\": \"a81e174b673e751b83d2197980d85837bcc54a9f\", \"libjingle_xmpp_unittests\": \"4cd38cfdabd930e9231cbc62f32d4716c17f07e9\", \"media_blink_unittests\": \"754d14d0e51d27c28f02c5b7793ac4be9f919f3e\", \"media_service_unittests\": \"9acc04572ef09f3a60ca0195ce309feac397a14b\", \"media_unittests\": \"9ae59dfc4779ebbfaa5f33b0242cfbc0145bd995\", \"midi_unittests\": \"70f36975a5e2f4148a42932fa298e77b65383870\", \"mojo_test_apk\": \"cef8152f5eec69258bacfb5b098ac34691d736ab\", \"mojo_unittests\": \"2f374cfa887db644f17b4484e6420b8ae18e9860\", \"net_unittests\": \"d670bf1f8d0c7f08757c07846478a00f014dd758\", \"sandbox_linux_unittests\": \"c5289bc80e8d33c9100c274106c4da96d30ada71\", \"services_unittests\": \"7406ed616bba3fae8bd155ddb51ee2ea97f12432\", \"shell_dialogs_unittests\": \"f3a9cdb1572743431920e1b944883d8fbfc5557c\", \"skia_unittests\": \"6de25a378c0909afd6b27cba27030b383f5ca858\", \"sql_unittests\": \"50debddc911c7d50d3869df3c48ebb6a4445c390\", \"storage_unittests\": \"7627ae25880f71cf48d4e8be65cc290605c3cf3a\", \"ui_android_unittests\": \"fbd3fe106f60ec44a5a50ac7cf99f1541e58daa2\", \"ui_base_unittests\": \"0c9d38bf6da6ba2451540e0557e3d26dad51d1a5\", \"ui_touch_selection_unittests\": \"4073c521706a18e2598022b67af17fed3e221215\", \"url_unittests\": \"1d5f7e7ffbced0126a2211cfa95741f533c9ee33\", \"viz_unittests\": \"288cd50a02c83e04506d8e02256f066eb6f12745\", \"wtf_unittests\": \"6233529ac9a092a36eb0d308a6999af8f3cb71fa\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_84527c5af4d4441fc5a14374d256be65769803505d9e2e72cad7cb7913806658_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-my8f\"], \"image\": [\"chrome-xenial-19120100-f3a09baa543\"], \"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\": [\"4709-f2c88b6\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}, \"ui\": {\"info\": \"Step('process clang code coverage data.generate metadata for 49 tests') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1575999162664804",
"status": "COMPLETED",
"status_changed_ts": "1575999163737422",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/2916",
"builder:android-code-coverage-native",
"buildset:commit/git/72bbbb91f7f5ca666ef2450dd972e522281694ed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/72bbbb91f7f5ca666ef2450dd972e522281694ed",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059868937640948912",
"scheduler_job_id:chromium/android-code-coverage-native",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8894438875345635552/+/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:4909afe6b0d84c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1576002033546606",
"url": "https://ci.chromium.org/b/8894438875345635552",
"utcnow_ts": "1576002034813490"
}
}
[18:20:34.824] Invocation finished in 48m48.450777622s with status FAILED