[16:26:58.662] New invocation is queued and will start shortly
[16:27:00.293] Starting the invocation (attempt 1)
[16:27:00.392] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:27:00.392] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:27:00.392] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059691820340985072",
"parameters_json": "{\"builder_name\":\"android-code-coverage-native\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"32e8a88366321562f622dacbd8ec22faed82bba7\"}}",
"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:9059691820340985072",
"scheduler_job_id:chromium/android-code-coverage-native",
"user_agent:luci-scheduler",
"buildset:commit/git/32e8a88366321562f622dacbd8ec22faed82bba7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/32e8a88366321562f622dacbd8ec22faed82bba7",
"gitiles_ref:refs/heads/master"
]
}
[16:27:02.284] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576168020779154",
"id": "8894261757401374240",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"32e8a88366321562f622dacbd8ec22faed82bba7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576168021925083",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/3004",
"builder:android-code-coverage-native",
"buildset:commit/git/32e8a88366321562f622dacbd8ec22faed82bba7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/32e8a88366321562f622dacbd8ec22faed82bba7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059691820340985072",
"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/8894261757401374240/+/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": "1576168021925219",
"url": "https://ci.chromium.org/b/8894261757401374240",
"utcnow_ts": "1576168022258382"
}
}
[16:27:02.284] Task URL: https://ci.chromium.org/b/8894261757401374240
[16:27:02.284] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:2:0) after 1m0s
[16:28:02.287] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:2:0)
[16:28:02.287] Timer tick, asking Buildbucket for the build status
[16:28:02.434] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:02.434] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:3:0) after 1m0s
[16:28:03.738] Received PubSub notification, asking Buildbucket for the build status
[16:28:04.007] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:02.564] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:3:0)
[16:29:02.564] Timer tick, asking Buildbucket for the build status
[16:29:03.129] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:03.129] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:5:0) after 1m0s
[16:30:03.276] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:5:0)
[16:30:03.276] Timer tick, asking Buildbucket for the build status
[16:30:03.867] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:03.867] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:6:0) after 1m0s
[16:31:04.163] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:6:0)
[16:31:04.163] Timer tick, asking Buildbucket for the build status
[16:31:04.647] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:04.647] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:7:0) after 1m0s
[16:32:04.807] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:7:0)
[16:32:04.807] Timer tick, asking Buildbucket for the build status
[16:32:05.400] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:05.400] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:8:0) after 1m0s
[16:33:05.549] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:8:0)
[16:33:05.549] Timer tick, asking Buildbucket for the build status
[16:33:05.749] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:05.749] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:9:0) after 1m0s
[16:34:05.880] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:9:0)
[16:34:05.880] Timer tick, asking Buildbucket for the build status
[16:34:06.144] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:06.144] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:10:0) after 1m0s
[16:35:06.304] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:10:0)
[16:35:06.304] Timer tick, asking Buildbucket for the build status
[16:35:06.580] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:06.580] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:11:0) after 1m0s
[16:36:06.883] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:11:0)
[16:36:06.883] Timer tick, asking Buildbucket for the build status
[16:36:07.234] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:07.234] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:12:0) after 1m0s
[16:37:07.571] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:12:0)
[16:37:07.571] Timer tick, asking Buildbucket for the build status
[16:37:07.869] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:07.869] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:13:0) after 1m0s
[16:38:08.332] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:13:0)
[16:38:08.332] Timer tick, asking Buildbucket for the build status
[16:38:08.536] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:08.536] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:14:0) after 1m0s
[16:39:08.674] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:14:0)
[16:39:08.674] Timer tick, asking Buildbucket for the build status
[16:39:10.750] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:10.750] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:15:0) after 1m0s
[16:40:10.859] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:15:0)
[16:40:10.859] Timer tick, asking Buildbucket for the build status
[16:40:11.368] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:11.368] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:16:0) after 1m0s
[16:41:11.560] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:16:0)
[16:41:11.560] Timer tick, asking Buildbucket for the build status
[16:41:11.969] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:11.969] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:17:0) after 1m0s
[16:42:12.169] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:17:0)
[16:42:12.169] Timer tick, asking Buildbucket for the build status
[16:42:12.553] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:12.553] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:18:0) after 1m0s
[16:43:12.749] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:18:0)
[16:43:12.749] Timer tick, asking Buildbucket for the build status
[16:43:12.971] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:12.971] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:19:0) after 1m0s
[16:44:13.205] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:19:0)
[16:44:13.205] Timer tick, asking Buildbucket for the build status
[16:44:13.423] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:13.423] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:20:0) after 1m0s
[16:45:13.471] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:20:0)
[16:45:13.471] Timer tick, asking Buildbucket for the build status
[16:45:14.292] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:14.292] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:21:0) after 1m0s
[16:46:14.358] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:21:0)
[16:46:14.358] Timer tick, asking Buildbucket for the build status
[16:46:14.669] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:14.669] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:22:0) after 1m0s
[16:47:14.783] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:22:0)
[16:47:14.783] Timer tick, asking Buildbucket for the build status
[16:47:15.376] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:15.376] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:23:0) after 1m0s
[16:48:15.442] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:23:0)
[16:48:15.442] Timer tick, asking Buildbucket for the build status
[16:48:15.984] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:15.984] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:24:0) after 1m0s
[16:49:16.089] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:24:0)
[16:49:16.089] Timer tick, asking Buildbucket for the build status
[16:49:17.133] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:17.133] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:25:0) after 1m0s
[16:50:17.260] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:25:0)
[16:50:17.260] Timer tick, asking Buildbucket for the build status
[16:50:17.704] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:17.704] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:26:0) after 1m0s
[16:51:17.778] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:26:0)
[16:51:17.778] Timer tick, asking Buildbucket for the build status
[16:51:18.587] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:18.587] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:27:0) after 1m0s
[16:52:18.757] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:27:0)
[16:52:18.757] Timer tick, asking Buildbucket for the build status
[16:52:19.329] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:19.329] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:28:0) after 1m0s
[16:53:19.394] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:28:0)
[16:53:19.394] Timer tick, asking Buildbucket for the build status
[16:53:19.994] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:19.994] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:29:0) after 1m0s
[16:54:20.065] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:29:0)
[16:54:20.065] Timer tick, asking Buildbucket for the build status
[16:54:20.248] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:20.248] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:30:0) after 1m0s
[16:55:20.273] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:30:0)
[16:55:20.273] Timer tick, asking Buildbucket for the build status
[16:55:20.507] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:20.507] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:31:0) after 1m0s
[16:56:20.614] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:31:0)
[16:56:20.614] Timer tick, asking Buildbucket for the build status
[16:56:20.919] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:20.919] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:32:0) after 1m0s
[16:57:21.212] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:32:0)
[16:57:21.212] Timer tick, asking Buildbucket for the build status
[16:57:21.820] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:21.820] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:33:0) after 1m0s
[16:58:22.096] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:33:0)
[16:58:22.096] Timer tick, asking Buildbucket for the build status
[16:58:22.408] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:22.408] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:34:0) after 1m0s
[16:59:22.673] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:34:0)
[16:59:22.673] Timer tick, asking Buildbucket for the build status
[16:59:22.875] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:22.875] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:35:0) after 1m0s
[17:00:22.977] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:35:0)
[17:00:22.977] Timer tick, asking Buildbucket for the build status
[17:00:23.597] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:23.597] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:36:0) after 1m0s
[17:01:23.672] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:36:0)
[17:01:23.672] Timer tick, asking Buildbucket for the build status
[17:01:24.198] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:24.199] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:37:0) after 1m0s
[17:02:24.275] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:37:0)
[17:02:24.275] Timer tick, asking Buildbucket for the build status
[17:02:24.488] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:24.488] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:38:0) after 1m0s
[17:03:24.619] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:38:0)
[17:03:24.619] Timer tick, asking Buildbucket for the build status
[17:03:24.937] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:24.937] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:39:0) after 1m0s
[17:04:25.164] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:39:0)
[17:04:25.164] Timer tick, asking Buildbucket for the build status
[17:04:25.517] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:25.517] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:40:0) after 1m0s
[17:05:25.638] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:40:0)
[17:05:25.638] Timer tick, asking Buildbucket for the build status
[17:05:26.298] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:26.298] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:41:0) after 1m0s
[17:06:26.421] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:41:0)
[17:06:26.421] Timer tick, asking Buildbucket for the build status
[17:06:26.697] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:26.697] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:42:0) after 1m0s
[17:07:26.860] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:42:0)
[17:07:26.860] Timer tick, asking Buildbucket for the build status
[17:07:27.109] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:27.109] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:43:0) after 1m0s
[17:08:27.194] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:43:0)
[17:08:27.194] Timer tick, asking Buildbucket for the build status
[17:08:27.379] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:27.379] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:44:0) after 1m0s
[17:09:27.573] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:44:0)
[17:09:27.573] Timer tick, asking Buildbucket for the build status
[17:09:27.806] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:27.806] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:45:0) after 1m0s
[17:10:27.865] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:45:0)
[17:10:27.866] Timer tick, asking Buildbucket for the build status
[17:10:28.235] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:28.235] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:46:0) after 1m0s
[17:11:28.457] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:46:0)
[17:11:28.457] Timer tick, asking Buildbucket for the build status
[17:11:28.783] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:28.783] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:47:0) after 1m0s
[17:12:29.195] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:47:0)
[17:12:29.195] Timer tick, asking Buildbucket for the build status
[17:12:29.495] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:29.495] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:48:0) after 1m0s
[17:13:29.918] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:48:0)
[17:13:29.918] Timer tick, asking Buildbucket for the build status
[17:13:30.167] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:30.167] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:49:0) after 1m0s
[17:14:30.801] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:49:0)
[17:14:30.801] Timer tick, asking Buildbucket for the build status
[17:14:31.415] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:31.415] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:50:0) after 1m0s
[17:15:31.711] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:50:0)
[17:15:31.711] Timer tick, asking Buildbucket for the build status
[17:15:32.877] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:32.877] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:51:0) after 1m0s
[17:16:33.014] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:51:0)
[17:16:33.014] Timer tick, asking Buildbucket for the build status
[17:16:36.059] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:36.059] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:52:0) after 1m0s
[17:17:36.437] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:52:0)
[17:17:36.437] Timer tick, asking Buildbucket for the build status
[17:17:37.894] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:37.894] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:53:0) after 1m0s
[17:18:38.320] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:53:0)
[17:18:38.320] Timer tick, asking Buildbucket for the build status
[17:18:39.514] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:39.514] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:54:0) after 1m0s
[17:19:39.538] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:54:0)
[17:19:39.538] Timer tick, asking Buildbucket for the build status
[17:19:40.285] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:40.285] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:55:0) after 1m0s
[17:20:40.383] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:55:0)
[17:20:40.383] Timer tick, asking Buildbucket for the build status
[17:20:41.167] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:41.167] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:56:0) after 1m0s
[17:21:41.229] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:56:0)
[17:21:41.229] Timer tick, asking Buildbucket for the build status
[17:21:42.469] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:42.469] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:57:0) after 1m0s
[17:22:42.717] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:57:0)
[17:22:42.717] Timer tick, asking Buildbucket for the build status
[17:22:43.008] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:43.008] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:58:0) after 1m0s
[17:23:43.172] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:58:0)
[17:23:43.172] Timer tick, asking Buildbucket for the build status
[17:23:43.377] Build 8894261757401374240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:43.377] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059691820340985072:59:0) after 1m0s
[17:24:18.157] Received PubSub notification, asking Buildbucket for the build status
[17:24:18.280] Build 8894261757401374240: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[17:24:18.280] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576171456425577",
"created_by": "project:chromium",
"created_ts": "1576168020779154",
"failure_reason": "BUILD_FAILURE",
"id": "8894261757401374240",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"32e8a88366321562f622dacbd8ec22faed82bba7\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('process clang code coverage data.Get all Android unstripped artifacts paths') (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\": 3004, \"got_angle_revision\": \"3c75d244d6f9ef1eb9f6f010f01828658fe9d38a\", \"got_dawn_revision\": \"af094e6a88d01073a4e5e15fa1b268a72bbb73aa\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"32e8a88366321562f622dacbd8ec22faed82bba7\", \"got_revision_cp\": \"refs/heads/master@{#724201}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"07958d452f93b6513ebf5cbae64a1325c1755dbf\", \"got_v8_revision\": \"5a2f2203c80defe0adc943a2c15ff51da7b24196\", \"got_v8_revision_cp\": \"refs/heads/8.1.18@{#1}\", \"got_webrtc_revision\": \"26fe811623627e1089a8df2c86a89dda2cd9d338\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30068}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"merged_profdata_gs_path\": \"postsubmit/chromium.googlesource.com/chromium/src/32e8a88366321562f622dacbd8ec22faed82bba7/ci/android-code-coverage-native/8894261757401374240/merged.profdata\", \"path_config\": \"generic\", \"process_coverage_data_failure\": true, \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"32e8a88366321562f622dacbd8ec22faed82bba7\", \"swarm_hashes\": {\"android_browsertests\": \"0a7442b5f119ff5cde0c727974b61ba2dcf2aefc\", \"angle_unittests\": \"67c874b13f684712c0132d2cb1fc86a4447092d0\", \"base_unittests\": \"d59c3d466ec670eaabd728cd56ed58ba3e648bea\", \"base_util_unittests\": \"3c8e553347b35fe96f14133ecc2d8e19a34a09b9\", \"blink_common_unittests\": \"03f51a803413a37e1f0e6ceff7ffa6190203858e\", \"blink_heap_unittests\": \"98f50decfda828622c9159fc0ee07ada51255aa3\", \"blink_platform_unittests\": \"4fa295cca302e423307e9d8d40699f3ab019f0f9\", \"boringssl_crypto_tests\": \"8ad7ec0ebd5e8c3c1144aee1edc345a587edbfef\", \"boringssl_ssl_tests\": \"2199eade832b02624f70d5f90906b65597124a5d\", \"breakpad_unittests\": \"f4f55f3831065f016a1ff06b5cb64e92087d2212\", \"cacheinvalidation_unittests\": \"091cc54a657905909d0bea52fa49445ec058802b\", \"capture_unittests\": \"99e0f77ea988d612dcd98372a69773a83d60364f\", \"cast_unittests\": \"956be18575b4086fd1db235bfeb34abbce6e14cc\", \"cc_unittests\": \"03161918b375df83a7f3b04a0e529c0222b5af72\", \"crypto_unittests\": \"ccfb79bf1de036c9961853666e718dc5b15f1e4b\", \"device_unittests\": \"227ddf76dfea317509002a897db23aaecfa149f5\", \"display_unittests\": \"686668be1af9144922e680a6dde23c6e227a03e4\", \"events_unittests\": \"288ba8c48ae304ec98da52be821f7421fdb4902a\", \"gcm_unit_tests\": \"05617ac7b2e443bebd33ea0c62d6171e0216b540\", \"gfx_unittests\": \"695a29ee69477954cd200586d950c6e3151cf6a9\", \"gin_unittests\": \"6e8cc8f6201fa04ddc05a0fbfb8f7b7388da9d3a\", \"gl_tests\": \"607e2ebd395eeb55ca7a8eedd74abbed867c92a4\", \"gl_unittests\": \"6ace21a776b9d9b668247bd00530b31d119cbb61\", \"google_apis_unittests\": \"17eba3c01bd7f380785cbdef857a6872a56e4959\", \"gpu_unittests\": \"f2612bf000937d5aa3ee5064bf7989affbecfa0f\", \"gwp_asan_unittests\": \"621468ce4d90e79b74ec0ab19ddb0c8fd249d04f\", \"ipc_tests\": \"c0f306719432b746b1be0cef6240ae7b079a8256\", \"jingle_unittests\": \"13916839d3759772c39ee1485d38ff888a58fe8b\", \"latency_unittests\": \"a5c037ef0e24000880faf259761be0b4e63c4589\", \"libjingle_xmpp_unittests\": \"e47240a826cb1946534d07a60ae86552e760a812\", \"media_blink_unittests\": \"d5f898ba2f0eedf5b49afbf99ce99e15fdfa98a0\", \"media_service_unittests\": \"21e406b0ad882b1e4c9928d77a974935a1ba0525\", \"media_unittests\": \"60f807cfad9728b90f379068c713708fef62d263\", \"midi_unittests\": \"2ea7c67ee0a71c312db31b399ec8818049e47039\", \"mojo_test_apk\": \"ea297dc24882cda589d9cca2afacaa1bee28c0e2\", \"mojo_unittests\": \"7d054a1500e4e0508a5a8fa2965e21be763dc35f\", \"net_unittests\": \"2b2fe56fc8400c83812015392b571fb3c11ed8b7\", \"sandbox_linux_unittests\": \"94988ebcd712c63613ab2974ff29f50c4900cf28\", \"services_unittests\": \"bd9c39b561caf391a0a816a60a505b0868da5c9d\", \"shell_dialogs_unittests\": \"1bedffb7cb7dd87a1ed5b78bc79abe5a09d687d6\", \"skia_unittests\": \"9503daf3613320f7abf2f7f9cd85b073333fb21f\", \"sql_unittests\": \"cc30237d6a0a6969bfcdc4bb97135229105eafb5\", \"storage_unittests\": \"3dda3054676e039006f0016f7ba1aa6408f66370\", \"ui_android_unittests\": \"3e34985a860d45f792555ae2ebf22226512d7ed9\", \"ui_base_unittests\": \"bf0e94019d488d25157ee3319a8b6363f8581537\", \"ui_touch_selection_unittests\": \"10afb3ce81583140f38ab73b2b03fa54d6474d68\", \"url_unittests\": \"ed5726a2e7b594584e7ef78f9d86077128fbd299\", \"viz_unittests\": \"65c2d6ec566b40af2e111b375d90bd9b5e4ec176\", \"wtf_unittests\": \"b7f9e2c0f4e41b0cf1cd25f2b2ad3cb429d76c70\"}, \"swarm_hashes_refs/heads/master(at){#724201}_without_patch\": {\"android_browsertests\": \"0a7442b5f119ff5cde0c727974b61ba2dcf2aefc\", \"angle_unittests\": \"67c874b13f684712c0132d2cb1fc86a4447092d0\", \"base_unittests\": \"d59c3d466ec670eaabd728cd56ed58ba3e648bea\", \"base_util_unittests\": \"3c8e553347b35fe96f14133ecc2d8e19a34a09b9\", \"blink_common_unittests\": \"03f51a803413a37e1f0e6ceff7ffa6190203858e\", \"blink_heap_unittests\": \"98f50decfda828622c9159fc0ee07ada51255aa3\", \"blink_platform_unittests\": \"4fa295cca302e423307e9d8d40699f3ab019f0f9\", \"boringssl_crypto_tests\": \"8ad7ec0ebd5e8c3c1144aee1edc345a587edbfef\", \"boringssl_ssl_tests\": \"2199eade832b02624f70d5f90906b65597124a5d\", \"breakpad_unittests\": \"f4f55f3831065f016a1ff06b5cb64e92087d2212\", \"cacheinvalidation_unittests\": \"091cc54a657905909d0bea52fa49445ec058802b\", \"capture_unittests\": \"99e0f77ea988d612dcd98372a69773a83d60364f\", \"cast_unittests\": \"956be18575b4086fd1db235bfeb34abbce6e14cc\", \"cc_unittests\": \"03161918b375df83a7f3b04a0e529c0222b5af72\", \"crypto_unittests\": \"ccfb79bf1de036c9961853666e718dc5b15f1e4b\", \"device_unittests\": \"227ddf76dfea317509002a897db23aaecfa149f5\", \"display_unittests\": \"686668be1af9144922e680a6dde23c6e227a03e4\", \"events_unittests\": \"288ba8c48ae304ec98da52be821f7421fdb4902a\", \"gcm_unit_tests\": \"05617ac7b2e443bebd33ea0c62d6171e0216b540\", \"gfx_unittests\": \"695a29ee69477954cd200586d950c6e3151cf6a9\", \"gin_unittests\": \"6e8cc8f6201fa04ddc05a0fbfb8f7b7388da9d3a\", \"gl_tests\": \"607e2ebd395eeb55ca7a8eedd74abbed867c92a4\", \"gl_unittests\": \"6ace21a776b9d9b668247bd00530b31d119cbb61\", \"google_apis_unittests\": \"17eba3c01bd7f380785cbdef857a6872a56e4959\", \"gpu_unittests\": \"f2612bf000937d5aa3ee5064bf7989affbecfa0f\", \"gwp_asan_unittests\": \"621468ce4d90e79b74ec0ab19ddb0c8fd249d04f\", \"ipc_tests\": \"c0f306719432b746b1be0cef6240ae7b079a8256\", \"jingle_unittests\": \"13916839d3759772c39ee1485d38ff888a58fe8b\", \"latency_unittests\": \"a5c037ef0e24000880faf259761be0b4e63c4589\", \"libjingle_xmpp_unittests\": \"e47240a826cb1946534d07a60ae86552e760a812\", \"media_blink_unittests\": \"d5f898ba2f0eedf5b49afbf99ce99e15fdfa98a0\", \"media_service_unittests\": \"21e406b0ad882b1e4c9928d77a974935a1ba0525\", \"media_unittests\": \"60f807cfad9728b90f379068c713708fef62d263\", \"midi_unittests\": \"2ea7c67ee0a71c312db31b399ec8818049e47039\", \"mojo_test_apk\": \"ea297dc24882cda589d9cca2afacaa1bee28c0e2\", \"mojo_unittests\": \"7d054a1500e4e0508a5a8fa2965e21be763dc35f\", \"net_unittests\": \"2b2fe56fc8400c83812015392b571fb3c11ed8b7\", \"sandbox_linux_unittests\": \"94988ebcd712c63613ab2974ff29f50c4900cf28\", \"services_unittests\": \"bd9c39b561caf391a0a816a60a505b0868da5c9d\", \"shell_dialogs_unittests\": \"1bedffb7cb7dd87a1ed5b78bc79abe5a09d687d6\", \"skia_unittests\": \"9503daf3613320f7abf2f7f9cd85b073333fb21f\", \"sql_unittests\": \"cc30237d6a0a6969bfcdc4bb97135229105eafb5\", \"storage_unittests\": \"3dda3054676e039006f0016f7ba1aa6408f66370\", \"ui_android_unittests\": \"3e34985a860d45f792555ae2ebf22226512d7ed9\", \"ui_base_unittests\": \"bf0e94019d488d25157ee3319a8b6363f8581537\", \"ui_touch_selection_unittests\": \"10afb3ce81583140f38ab73b2b03fa54d6474d68\", \"url_unittests\": \"ed5726a2e7b594584e7ef78f9d86077128fbd299\", \"viz_unittests\": \"65c2d6ec566b40af2e111b375d90bd9b5e4ec176\", \"wtf_unittests\": \"b7f9e2c0f4e41b0cf1cd25f2b2ad3cb429d76c70\"}}, \"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\": [\"4713-a14a20b\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}, \"ui\": {\"info\": \"Step('process clang code coverage data.Get all Android unstripped artifacts paths') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576168081077904",
"status": "COMPLETED",
"status_changed_ts": "1576168081885727",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/3004",
"builder:android-code-coverage-native",
"buildset:commit/git/32e8a88366321562f622dacbd8ec22faed82bba7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/32e8a88366321562f622dacbd8ec22faed82bba7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059691820340985072",
"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/8894261757401374240/+/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:4913c0eaa09bb810",
"user_agent:luci-scheduler"
],
"updated_ts": "1576171457635239",
"url": "https://ci.chromium.org/b/8894261757401374240",
"utcnow_ts": "1576171458269876"
}
}
[17:24:18.280] Invocation finished in 57m19.686642239s with status FAILED