[15:01:58.331] New invocation is queued and will start shortly
[15:01:59.852] Starting the invocation (attempt 1)
[15:01:59.892] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:01:59.892] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:01:59.892] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059878362303404688",
"parameters_json": "{\"builder_name\":\"android-code-coverage-native\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4486ed86735e6f311f59e15433a4d6906548b4c7\"}}",
"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:9059878362303404688",
"scheduler_job_id:chromium/android-code-coverage-native",
"user_agent:luci-scheduler",
"buildset:commit/git/4486ed86735e6f311f59e15433a4d6906548b4c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4486ed86735e6f311f59e15433a4d6906548b4c7",
"gitiles_ref:refs/heads/master"
]
}
[15:02:00.980] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575990120072539",
"id": "8894448299814044480",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4486ed86735e6f311f59e15433a4d6906548b4c7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575990120692117",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/2912",
"builder:android-code-coverage-native",
"buildset:commit/git/4486ed86735e6f311f59e15433a4d6906548b4c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4486ed86735e6f311f59e15433a4d6906548b4c7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059878362303404688",
"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/8894448299814044480/+/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": "1575990120692230",
"url": "https://ci.chromium.org/b/8894448299814044480",
"utcnow_ts": "1575990120963551"
}
}
[15:02:00.980] Task URL: https://ci.chromium.org/b/8894448299814044480
[15:02:00.980] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:2:0) after 1m0s
[15:02:57.101] Received PubSub notification, asking Buildbucket for the build status
[15:02:57.258] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:01.133] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:2:0)
[15:03:01.133] Timer tick, asking Buildbucket for the build status
[15:03:01.547] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:01.547] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:4:0) after 1m0s
[15:04:01.599] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:4:0)
[15:04:01.599] Timer tick, asking Buildbucket for the build status
[15:04:01.957] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:01.957] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:5:0) after 1m0s
[15:05:01.968] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:5:0)
[15:05:01.968] Timer tick, asking Buildbucket for the build status
[15:05:02.317] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:02.317] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:6:0) after 1m0s
[15:06:02.415] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:6:0)
[15:06:02.415] Timer tick, asking Buildbucket for the build status
[15:06:03.500] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:03.500] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:7:0) after 1m0s
[15:07:03.548] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:7:0)
[15:07:03.548] Timer tick, asking Buildbucket for the build status
[15:07:03.735] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:03.735] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:8:0) after 1m0s
[15:08:03.866] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:8:0)
[15:08:03.866] Timer tick, asking Buildbucket for the build status
[15:08:04.153] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:04.153] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:9:0) after 1m0s
[15:09:04.275] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:9:0)
[15:09:04.275] Timer tick, asking Buildbucket for the build status
[15:09:04.538] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:04.538] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:10:0) after 1m0s
[15:10:04.842] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:10:0)
[15:10:04.842] Timer tick, asking Buildbucket for the build status
[15:10:05.073] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:05.073] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:11:0) after 1m0s
[15:11:05.173] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:11:0)
[15:11:05.173] Timer tick, asking Buildbucket for the build status
[15:11:05.549] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:05.549] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:12:0) after 1m0s
[15:12:05.625] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:12:0)
[15:12:05.625] Timer tick, asking Buildbucket for the build status
[15:12:05.811] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:05.811] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:13:0) after 1m0s
[15:13:05.948] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:13:0)
[15:13:05.948] Timer tick, asking Buildbucket for the build status
[15:13:06.261] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:06.261] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:14:0) after 1m0s
[15:14:06.386] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:14:0)
[15:14:06.386] Timer tick, asking Buildbucket for the build status
[15:14:06.507] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:06.507] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:15:0) after 1m0s
[15:15:06.557] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:15:0)
[15:15:06.557] Timer tick, asking Buildbucket for the build status
[15:15:07.126] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:07.126] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:16:0) after 1m0s
[15:16:07.213] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:16:0)
[15:16:07.213] Timer tick, asking Buildbucket for the build status
[15:16:07.414] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:07.414] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:17:0) after 1m0s
[15:17:07.537] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:17:0)
[15:17:07.537] Timer tick, asking Buildbucket for the build status
[15:17:07.877] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:07.877] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:18:0) after 1m0s
[15:18:08.004] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:18:0)
[15:18:08.004] Timer tick, asking Buildbucket for the build status
[15:18:08.350] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:08.350] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:19:0) after 1m0s
[15:19:08.375] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:19:0)
[15:19:08.375] Timer tick, asking Buildbucket for the build status
[15:19:09.061] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:09.061] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:20:0) after 1m0s
[15:20:09.080] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:20:0)
[15:20:09.080] Timer tick, asking Buildbucket for the build status
[15:20:09.257] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:09.257] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:21:0) after 1m0s
[15:21:09.319] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:21:0)
[15:21:09.319] Timer tick, asking Buildbucket for the build status
[15:21:09.501] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:09.501] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:22:0) after 1m0s
[15:22:09.590] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:22:0)
[15:22:09.590] Timer tick, asking Buildbucket for the build status
[15:22:09.746] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:09.746] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:23:0) after 1m0s
[15:23:09.778] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:23:0)
[15:23:09.778] Timer tick, asking Buildbucket for the build status
[15:23:10.975] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:10.975] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:24:0) after 1m0s
[15:24:11.091] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:24:0)
[15:24:11.091] Timer tick, asking Buildbucket for the build status
[15:24:11.593] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:11.593] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:25:0) after 1m0s
[15:25:11.607] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:25:0)
[15:25:11.607] Timer tick, asking Buildbucket for the build status
[15:25:12.033] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:12.033] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:26:0) after 1m0s
[15:26:12.012] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:26:0)
[15:26:12.012] Timer tick, asking Buildbucket for the build status
[15:26:12.705] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:12.705] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:27:0) after 1m0s
[15:27:12.767] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:27:0)
[15:27:12.767] Timer tick, asking Buildbucket for the build status
[15:27:13.604] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:13.604] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:28:0) after 1m0s
[15:28:13.697] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:28:0)
[15:28:13.697] Timer tick, asking Buildbucket for the build status
[15:28:13.876] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:13.876] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:29:0) after 1m0s
[15:29:13.931] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:29:0)
[15:29:13.931] Timer tick, asking Buildbucket for the build status
[15:29:14.227] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:14.227] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:30:0) after 1m0s
[15:30:14.308] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:30:0)
[15:30:14.308] Timer tick, asking Buildbucket for the build status
[15:30:14.877] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:14.877] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:31:0) after 1m0s
[15:31:14.942] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:31:0)
[15:31:14.942] Timer tick, asking Buildbucket for the build status
[15:31:15.651] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:15.651] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:32:0) after 1m0s
[15:32:15.803] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:32:0)
[15:32:15.804] Timer tick, asking Buildbucket for the build status
[15:32:16.280] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:16.280] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:33:0) after 1m0s
[15:33:16.576] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:33:0)
[15:33:16.576] Timer tick, asking Buildbucket for the build status
[15:33:17.194] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:17.194] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:34:0) after 1m0s
[15:34:17.264] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:34:0)
[15:34:17.264] Timer tick, asking Buildbucket for the build status
[15:34:18.486] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:18.486] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:35:0) after 1m0s
[15:35:18.485] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:35:0)
[15:35:18.486] Timer tick, asking Buildbucket for the build status
[15:35:18.760] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:18.760] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:36:0) after 1m0s
[15:36:18.874] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:36:0)
[15:36:18.874] Timer tick, asking Buildbucket for the build status
[15:36:20.543] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:20.543] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:37:0) after 1m0s
[15:37:20.531] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:37:0)
[15:37:20.531] Timer tick, asking Buildbucket for the build status
[15:37:20.816] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:20.816] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:38:0) after 1m0s
[15:38:20.945] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:38:0)
[15:38:20.945] Timer tick, asking Buildbucket for the build status
[15:38:21.954] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:21.954] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:39:0) after 1m0s
[15:39:22.051] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:39:0)
[15:39:22.051] Timer tick, asking Buildbucket for the build status
[15:39:22.277] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:22.277] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:40:0) after 1m0s
[15:40:22.445] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:40:0)
[15:40:22.445] Timer tick, asking Buildbucket for the build status
[15:40:22.620] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:22.620] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:41:0) after 1m0s
[15:41:22.821] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:41:0)
[15:41:22.821] Timer tick, asking Buildbucket for the build status
[15:41:23.014] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:23.014] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:42:0) after 1m0s
[15:42:23.154] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:42:0)
[15:42:23.154] Timer tick, asking Buildbucket for the build status
[15:42:23.673] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:23.673] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:43:0) after 1m0s
[15:43:23.895] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:43:0)
[15:43:23.895] Timer tick, asking Buildbucket for the build status
[15:43:24.081] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:24.081] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:44:0) after 1m0s
[15:44:24.228] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:44:0)
[15:44:24.228] Timer tick, asking Buildbucket for the build status
[15:44:24.430] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:24.430] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:45:0) after 1m0s
[15:45:24.597] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:45:0)
[15:45:24.597] Timer tick, asking Buildbucket for the build status
[15:45:25.267] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:25.267] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:46:0) after 1m0s
[15:46:25.452] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:46:0)
[15:46:25.452] Timer tick, asking Buildbucket for the build status
[15:46:25.600] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:25.600] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:47:0) after 1m0s
[15:47:25.675] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:47:0)
[15:47:25.675] Timer tick, asking Buildbucket for the build status
[15:47:25.924] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:25.924] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:48:0) after 1m0s
[15:48:26.022] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:48:0)
[15:48:26.022] Timer tick, asking Buildbucket for the build status
[15:48:26.219] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:26.219] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:49:0) after 1m0s
[15:49:26.392] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:49:0)
[15:49:26.392] Timer tick, asking Buildbucket for the build status
[15:49:26.884] Build 8894448299814044480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:26.884] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9059878362303404688:50:0) after 1m0s
[15:49:38.826] Received PubSub notification, asking Buildbucket for the build status
[15:49:39.357] Build 8894448299814044480: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:49:39.357] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1575992978226569",
"created_by": "project:chromium",
"created_ts": "1575990120072539",
"failure_reason": "BUILD_FAILURE",
"id": "8894448299814044480",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4486ed86735e6f311f59e15433a4d6906548b4c7\"}}",
"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\": 2912, \"coverage_gs_bucket\": \"code-coverage-data\", \"coverage_is_presubmit\": false, \"coverage_metadata_gs_path\": \"postsubmit/chromium.googlesource.com/chromium/src/4486ed86735e6f311f59e15433a4d6906548b4c7/ci/android-code-coverage-native/8894448299814044480/metadata\", \"got_angle_revision\": \"f60da87424a4747142d3f7187a55c1e19869a663\", \"got_dawn_revision\": \"ff8b3f43972342de3ea48cb94c036d8a7b7089c5\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"4486ed86735e6f311f59e15433a4d6906548b4c7\", \"got_revision_cp\": \"refs/heads/master@{#723355}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"4cf92db35cb93999166c6782f0f964cc0c83eb1d\", \"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/4486ed86735e6f311f59e15433a4d6906548b4c7/ci/android-code-coverage-native/8894448299814044480/merged.profdata\", \"path_config\": \"generic\", \"process_coverage_data_failure\": true, \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4486ed86735e6f311f59e15433a4d6906548b4c7\", \"swarm_hashes\": {\"android_browsertests\": \"5a978dbada56fbcfc1a61cb0f770a45b44064e2a\", \"angle_unittests\": \"d4fbb30e5af975139886c3cae2a80c10250f52f3\", \"base_unittests\": \"a40202c268a5af74dc6a98e587c42deab326b5b9\", \"base_util_unittests\": \"b0f0f6c88d240389efe1f2b2e684afac3d9653ef\", \"blink_common_unittests\": \"1cdb5603c4e14ce5e81b05173faad2009865a3e3\", \"blink_heap_unittests\": \"8706f87e2a1ffc54328a93b5c6f403f87101b8eb\", \"blink_platform_unittests\": \"d5569ef0949ff4ead7ac84b5e4ac7984ba632911\", \"boringssl_crypto_tests\": \"f69a5cf2a1fdfd78560f29c09fca42604c6735dc\", \"boringssl_ssl_tests\": \"1e7c07b57630a5843b3039e1fe0037e6e333ab65\", \"breakpad_unittests\": \"a61c26a8b115ba5c4a6eaf812d73638289c2770e\", \"cacheinvalidation_unittests\": \"733d481da2ed24562728d76e4ca28c1e2da4d580\", \"capture_unittests\": \"975523e0f064da25dbe97e60b9deb2b4b652fb6c\", \"cast_unittests\": \"047c5fafa992f806ce37e8fd71c3792afa385bc3\", \"cc_unittests\": \"72a5c6a0a2db43f1bac95f7fecea2d438cd54cd7\", \"crypto_unittests\": \"51a413ce0857a8464afe0f89dfdfc84c1b39766b\", \"device_unittests\": \"4c9f566705b267689bad7e31d4951ceade787a5b\", \"display_unittests\": \"8c6a6adbf40c94b5a453ba330ff880043c70e613\", \"events_unittests\": \"0c061cb8e5535434c8701352d8b2e639098907a7\", \"gcm_unit_tests\": \"1674590e0ebb32d2064ee64bf33aa0069e1698b9\", \"gfx_unittests\": \"0c47929c89f61436d4adb5d83dd30d4316f0d3f7\", \"gin_unittests\": \"db21a43120545410f6db5cc75f85edb9a60933b6\", \"gl_tests\": \"2ffe3d050c837cb36afb589bcfb01b38e2d9c939\", \"gl_unittests\": \"ca290b061e6893303e1970c48888628b6a28251c\", \"google_apis_unittests\": \"f4e04b8fe445f6b5a5cb19f2d276c2aa875c284a\", \"gpu_unittests\": \"10ce909e004786e085278fdd7bd9cfdd82573257\", \"gwp_asan_unittests\": \"60e7362da58a6f0b284cd25fc0f29a18472aab26\", \"ipc_tests\": \"f10fe2ce29456534b20bc6a6c6e20ac7e9bd8e1b\", \"jingle_unittests\": \"ba23a88c4ac1957cac3821fc384df37a6e352902\", \"latency_unittests\": \"d5bcf35fd7fd9c29435ba5b315853193812419fa\", \"libjingle_xmpp_unittests\": \"14d394642809053a78ffc33a33e1483dcbb5d104\", \"media_blink_unittests\": \"3fa6c7e87b1076bf57f84e41b25c2f4309c7260c\", \"media_service_unittests\": \"45c58e2556082ab8a999b82bd6bce564a2ed8232\", \"media_unittests\": \"e475b9b8229d066aa0909d868f75bd79468e626d\", \"midi_unittests\": \"46a8bf7003e819e39dfdcf6f0d44dd120f9e0f7a\", \"mojo_test_apk\": \"28fc658c7fced4e04d5ce7b1fcd3cd8fdcdf2409\", \"mojo_unittests\": \"41aba71beee588a020d2a65c4473f0c3e3774745\", \"net_unittests\": \"7728d54d3cbbf3919979af409baba38c794f165b\", \"sandbox_linux_unittests\": \"96dfed6492f34019055ba8c673c051de00e26bba\", \"services_unittests\": \"4a99d6e3efbc9c5b54c9b2898edf229d05f95590\", \"shell_dialogs_unittests\": \"e04e7970f7f3f7d1e136b6bb5c350d2341641dca\", \"skia_unittests\": \"c89f37e586941a9cf63a5f55285dfdc74c121b95\", \"sql_unittests\": \"d7399e3d3a1983d82d1e8ae29a337a10797bdb8f\", \"storage_unittests\": \"d601fc9495ecc8510d28d1c8f407d9f01d3007f7\", \"ui_android_unittests\": \"9d55bbbcf05a75fa5eed060f1b2849e6bd1383bb\", \"ui_base_unittests\": \"7b77a32624aad15eb48a4443bfeb01307d8ae0a8\", \"ui_touch_selection_unittests\": \"1ca2d2e28eab1724bd976a6e89a8589e6f856937\", \"url_unittests\": \"6fbf4fa315ab417449b2280acaacff27355d2235\", \"viz_unittests\": \"b3167829dedd342f9cc977cfa9ccca2643a10d3e\", \"wtf_unittests\": \"9a6197ff90d2fb9e1065befd49d8248aacb26c2a\"}, \"swarm_hashes_refs/heads/master(at){#723355}_without_patch\": {\"android_browsertests\": \"5a978dbada56fbcfc1a61cb0f770a45b44064e2a\", \"angle_unittests\": \"d4fbb30e5af975139886c3cae2a80c10250f52f3\", \"base_unittests\": \"a40202c268a5af74dc6a98e587c42deab326b5b9\", \"base_util_unittests\": \"b0f0f6c88d240389efe1f2b2e684afac3d9653ef\", \"blink_common_unittests\": \"1cdb5603c4e14ce5e81b05173faad2009865a3e3\", \"blink_heap_unittests\": \"8706f87e2a1ffc54328a93b5c6f403f87101b8eb\", \"blink_platform_unittests\": \"d5569ef0949ff4ead7ac84b5e4ac7984ba632911\", \"boringssl_crypto_tests\": \"f69a5cf2a1fdfd78560f29c09fca42604c6735dc\", \"boringssl_ssl_tests\": \"1e7c07b57630a5843b3039e1fe0037e6e333ab65\", \"breakpad_unittests\": \"a61c26a8b115ba5c4a6eaf812d73638289c2770e\", \"cacheinvalidation_unittests\": \"733d481da2ed24562728d76e4ca28c1e2da4d580\", \"capture_unittests\": \"975523e0f064da25dbe97e60b9deb2b4b652fb6c\", \"cast_unittests\": \"047c5fafa992f806ce37e8fd71c3792afa385bc3\", \"cc_unittests\": \"72a5c6a0a2db43f1bac95f7fecea2d438cd54cd7\", \"crypto_unittests\": \"51a413ce0857a8464afe0f89dfdfc84c1b39766b\", \"device_unittests\": \"4c9f566705b267689bad7e31d4951ceade787a5b\", \"display_unittests\": \"8c6a6adbf40c94b5a453ba330ff880043c70e613\", \"events_unittests\": \"0c061cb8e5535434c8701352d8b2e639098907a7\", \"gcm_unit_tests\": \"1674590e0ebb32d2064ee64bf33aa0069e1698b9\", \"gfx_unittests\": \"0c47929c89f61436d4adb5d83dd30d4316f0d3f7\", \"gin_unittests\": \"db21a43120545410f6db5cc75f85edb9a60933b6\", \"gl_tests\": \"2ffe3d050c837cb36afb589bcfb01b38e2d9c939\", \"gl_unittests\": \"ca290b061e6893303e1970c48888628b6a28251c\", \"google_apis_unittests\": \"f4e04b8fe445f6b5a5cb19f2d276c2aa875c284a\", \"gpu_unittests\": \"10ce909e004786e085278fdd7bd9cfdd82573257\", \"gwp_asan_unittests\": \"60e7362da58a6f0b284cd25fc0f29a18472aab26\", \"ipc_tests\": \"f10fe2ce29456534b20bc6a6c6e20ac7e9bd8e1b\", \"jingle_unittests\": \"ba23a88c4ac1957cac3821fc384df37a6e352902\", \"latency_unittests\": \"d5bcf35fd7fd9c29435ba5b315853193812419fa\", \"libjingle_xmpp_unittests\": \"14d394642809053a78ffc33a33e1483dcbb5d104\", \"media_blink_unittests\": \"3fa6c7e87b1076bf57f84e41b25c2f4309c7260c\", \"media_service_unittests\": \"45c58e2556082ab8a999b82bd6bce564a2ed8232\", \"media_unittests\": \"e475b9b8229d066aa0909d868f75bd79468e626d\", \"midi_unittests\": \"46a8bf7003e819e39dfdcf6f0d44dd120f9e0f7a\", \"mojo_test_apk\": \"28fc658c7fced4e04d5ce7b1fcd3cd8fdcdf2409\", \"mojo_unittests\": \"41aba71beee588a020d2a65c4473f0c3e3774745\", \"net_unittests\": \"7728d54d3cbbf3919979af409baba38c794f165b\", \"sandbox_linux_unittests\": \"96dfed6492f34019055ba8c673c051de00e26bba\", \"services_unittests\": \"4a99d6e3efbc9c5b54c9b2898edf229d05f95590\", \"shell_dialogs_unittests\": \"e04e7970f7f3f7d1e136b6bb5c350d2341641dca\", \"skia_unittests\": \"c89f37e586941a9cf63a5f55285dfdc74c121b95\", \"sql_unittests\": \"d7399e3d3a1983d82d1e8ae29a337a10797bdb8f\", \"storage_unittests\": \"d601fc9495ecc8510d28d1c8f407d9f01d3007f7\", \"ui_android_unittests\": \"9d55bbbcf05a75fa5eed060f1b2849e6bd1383bb\", \"ui_base_unittests\": \"7b77a32624aad15eb48a4443bfeb01307d8ae0a8\", \"ui_touch_selection_unittests\": \"1ca2d2e28eab1724bd976a6e89a8589e6f856937\", \"url_unittests\": \"6fbf4fa315ab417449b2280acaacff27355d2235\", \"viz_unittests\": \"b3167829dedd342f9cc977cfa9ccca2643a10d3e\", \"wtf_unittests\": \"9a6197ff90d2fb9e1065befd49d8248aacb26c2a\"}}, \"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": "1575990175869275",
"status": "COMPLETED",
"status_changed_ts": "1575990176647099",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/2912",
"builder:android-code-coverage-native",
"buildset:commit/git/4486ed86735e6f311f59e15433a4d6906548b4c7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4486ed86735e6f311f59e15433a4d6906548b4c7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059878362303404688",
"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/8894448299814044480/+/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:490926cbd827fb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1575992978459336",
"url": "https://ci.chromium.org/b/8894448299814044480",
"utcnow_ts": "1575992979346252"
}
}
[15:49:39.357] Invocation finished in 47m41.043424429s with status FAILED