[00:44:18.042] New invocation is queued and will start shortly
[00:44:19.165] Starting the invocation (attempt 1)
[00:44:19.254] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:44:19.254] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:44:19.254] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9036286514097409328",
"parameters_json": "{\"builder_name\":\"android-code-coverage-native\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"83392f747232d6715966c263e9c9904bada8c888\"}}",
"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:9036286514097409328",
"scheduler_job_id:chromium/android-code-coverage-native",
"user_agent:luci-scheduler",
"buildset:commit/git/83392f747232d6715966c263e9c9904bada8c888",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/83392f747232d6715966c263e9c9904bada8c888",
"gitiles_ref:refs/heads/master"
]
}
[00:44:19.985] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1598489059381642",
"id": "8870856452028312048",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"83392f747232d6715966c263e9c9904bada8c888\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1598489059839181",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/8241",
"builder:android-code-coverage-native",
"buildset:commit/git/83392f747232d6715966c263e9c9904bada8c888",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/83392f747232d6715966c263e9c9904bada8c888",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036286514097409328",
"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/8870856452028312048/+/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": "1598489059839306",
"url": "https://ci.chromium.org/b/8870856452028312048",
"utcnow_ts": "1598489059975699"
}
}
[00:44:19.985] Task URL: https://ci.chromium.org/b/8870856452028312048
[00:44:19.985] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:2:0) after 1m0s
[00:44:59.289] Received PubSub notification, asking Buildbucket for the build status
[00:44:59.602] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:20.055] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:2:0)
[00:45:20.055] Timer tick, asking Buildbucket for the build status
[00:45:20.507] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:20.507] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:4:0) after 1m0s
[00:46:20.569] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:4:0)
[00:46:20.569] Timer tick, asking Buildbucket for the build status
[00:46:20.696] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:20.696] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:5:0) after 1m0s
[00:47:20.769] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:5:0)
[00:47:20.769] Timer tick, asking Buildbucket for the build status
[00:47:21.014] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:21.015] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:6:0) after 1m0s
[00:48:21.115] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:6:0)
[00:48:21.115] Timer tick, asking Buildbucket for the build status
[00:48:21.597] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:21.597] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:7:0) after 1m0s
[00:49:21.683] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:7:0)
[00:49:21.683] Timer tick, asking Buildbucket for the build status
[00:49:22.257] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:22.257] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:8:0) after 1m0s
[00:50:22.320] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:8:0)
[00:50:22.320] Timer tick, asking Buildbucket for the build status
[00:50:22.637] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:22.637] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:9:0) after 1m0s
[00:51:22.709] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:9:0)
[00:51:22.709] Timer tick, asking Buildbucket for the build status
[00:51:22.952] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:22.952] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:10:0) after 1m0s
[00:52:23.053] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:10:0)
[00:52:23.053] Timer tick, asking Buildbucket for the build status
[00:52:23.146] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:23.146] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:11:0) after 1m0s
[00:53:23.179] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:11:0)
[00:53:23.179] Timer tick, asking Buildbucket for the build status
[00:53:23.274] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:23.274] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:12:0) after 1m0s
[00:54:23.330] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:12:0)
[00:54:23.330] Timer tick, asking Buildbucket for the build status
[00:54:23.477] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:23.477] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:13:0) after 1m0s
[00:55:23.506] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:13:0)
[00:55:23.506] Timer tick, asking Buildbucket for the build status
[00:55:23.585] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:23.585] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:14:0) after 1m0s
[00:56:23.692] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:14:0)
[00:56:23.692] Timer tick, asking Buildbucket for the build status
[00:56:23.763] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:23.763] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:15:0) after 1m0s
[00:57:23.819] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:15:0)
[00:57:23.819] Timer tick, asking Buildbucket for the build status
[00:57:23.888] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:23.888] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:16:0) after 1m0s
[00:58:23.940] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:16:0)
[00:58:23.940] Timer tick, asking Buildbucket for the build status
[00:58:24.043] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:24.043] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:17:0) after 1m0s
[00:59:24.147] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:17:0)
[00:59:24.147] Timer tick, asking Buildbucket for the build status
[00:59:24.616] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:24.616] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:18:0) after 1m0s
[01:00:24.852] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:18:0)
[01:00:24.852] Timer tick, asking Buildbucket for the build status
[01:00:24.932] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:24.932] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:19:0) after 1m0s
[01:01:25.036] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:19:0)
[01:01:25.036] Timer tick, asking Buildbucket for the build status
[01:01:25.112] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:25.112] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:20:0) after 1m0s
[01:02:25.222] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:20:0)
[01:02:25.222] Timer tick, asking Buildbucket for the build status
[01:02:25.331] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:25.331] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:21:0) after 1m0s
[01:03:25.353] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:21:0)
[01:03:25.353] Timer tick, asking Buildbucket for the build status
[01:03:25.444] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:25.445] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:22:0) after 1m0s
[01:04:25.439] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:22:0)
[01:04:25.439] Timer tick, asking Buildbucket for the build status
[01:04:25.581] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:25.581] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:23:0) after 1m0s
[01:05:25.689] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:23:0)
[01:05:25.689] Timer tick, asking Buildbucket for the build status
[01:05:25.811] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:25.811] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:24:0) after 1m0s
[01:06:25.957] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:24:0)
[01:06:25.957] Timer tick, asking Buildbucket for the build status
[01:06:26.045] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:26.045] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:25:0) after 1m0s
[01:07:26.159] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:25:0)
[01:07:26.159] Timer tick, asking Buildbucket for the build status
[01:07:26.283] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:26.284] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:26:0) after 1m0s
[01:08:26.461] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:26:0)
[01:08:26.461] Timer tick, asking Buildbucket for the build status
[01:08:26.609] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:26.609] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:27:0) after 1m0s
[01:09:26.602] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:27:0)
[01:09:26.602] Timer tick, asking Buildbucket for the build status
[01:09:26.774] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:26.774] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:28:0) after 1m0s
[01:10:26.787] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:28:0)
[01:10:26.787] Timer tick, asking Buildbucket for the build status
[01:10:27.022] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:27.022] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:29:0) after 1m0s
[01:11:27.039] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:29:0)
[01:11:27.039] Timer tick, asking Buildbucket for the build status
[01:11:27.192] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:27.192] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:30:0) after 1m0s
[01:12:27.311] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:30:0)
[01:12:27.311] Timer tick, asking Buildbucket for the build status
[01:12:27.745] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:27.745] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:31:0) after 1m0s
[01:13:27.760] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:31:0)
[01:13:27.760] Timer tick, asking Buildbucket for the build status
[01:13:28.092] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:28.092] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:32:0) after 1m0s
[01:14:28.255] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:32:0)
[01:14:28.255] Timer tick, asking Buildbucket for the build status
[01:14:28.526] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:28.526] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:33:0) after 1m0s
[01:15:28.720] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:33:0)
[01:15:28.720] Timer tick, asking Buildbucket for the build status
[01:15:28.888] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:28.888] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:34:0) after 1m0s
[01:16:28.954] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:34:0)
[01:16:28.954] Timer tick, asking Buildbucket for the build status
[01:16:29.125] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:29.125] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:35:0) after 1m0s
[01:17:29.243] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:35:0)
[01:17:29.243] Timer tick, asking Buildbucket for the build status
[01:17:29.801] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:29.801] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:36:0) after 1m0s
[01:18:29.941] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:36:0)
[01:18:29.941] Timer tick, asking Buildbucket for the build status
[01:18:30.363] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:30.363] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:37:0) after 1m0s
[01:19:30.437] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:37:0)
[01:19:30.437] Timer tick, asking Buildbucket for the build status
[01:19:30.938] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:30.938] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:38:0) after 1m0s
[01:20:31.041] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:38:0)
[01:20:31.042] Timer tick, asking Buildbucket for the build status
[01:20:31.189] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:31.189] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:39:0) after 1m0s
[01:21:31.196] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:39:0)
[01:21:31.196] Timer tick, asking Buildbucket for the build status
[01:21:31.353] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:31.353] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:40:0) after 1m0s
[01:22:31.471] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:40:0)
[01:22:31.471] Timer tick, asking Buildbucket for the build status
[01:22:31.536] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:31.536] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:41:0) after 1m0s
[01:23:31.567] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:41:0)
[01:23:31.567] Timer tick, asking Buildbucket for the build status
[01:23:31.780] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:31.780] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:42:0) after 1m0s
[01:24:31.800] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:42:0)
[01:24:31.800] Timer tick, asking Buildbucket for the build status
[01:24:31.928] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:31.928] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:43:0) after 1m0s
[01:25:31.989] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:43:0)
[01:25:31.989] Timer tick, asking Buildbucket for the build status
[01:25:32.397] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:32.397] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:44:0) after 1m0s
[01:26:32.434] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:44:0)
[01:26:32.434] Timer tick, asking Buildbucket for the build status
[01:26:32.903] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:32.903] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:45:0) after 1m0s
[01:27:32.962] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:45:0)
[01:27:32.962] Timer tick, asking Buildbucket for the build status
[01:27:33.048] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:33.048] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:46:0) after 1m0s
[01:28:33.206] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:46:0)
[01:28:33.206] Timer tick, asking Buildbucket for the build status
[01:28:33.441] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:33.441] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:47:0) after 1m0s
[01:29:33.572] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:47:0)
[01:29:33.572] Timer tick, asking Buildbucket for the build status
[01:29:33.701] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:33.701] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:48:0) after 1m0s
[01:30:33.802] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:48:0)
[01:30:33.802] Timer tick, asking Buildbucket for the build status
[01:30:34.571] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:34.571] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:49:0) after 1m0s
[01:31:34.667] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:49:0)
[01:31:34.667] Timer tick, asking Buildbucket for the build status
[01:31:35.094] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:35.094] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:50:0) after 1m0s
[01:32:35.184] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:50:0)
[01:32:35.184] Timer tick, asking Buildbucket for the build status
[01:32:35.252] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:35.253] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:51:0) after 1m0s
[01:33:35.373] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:51:0)
[01:33:35.373] Timer tick, asking Buildbucket for the build status
[01:33:35.460] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:35.460] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:52:0) after 1m0s
[01:34:35.586] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:52:0)
[01:34:35.586] Timer tick, asking Buildbucket for the build status
[01:34:36.154] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:36.154] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:53:0) after 1m0s
[01:35:36.153] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:53:0)
[01:35:36.153] Timer tick, asking Buildbucket for the build status
[01:35:36.237] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:36.237] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:54:0) after 1m0s
[01:36:36.312] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:54:0)
[01:36:36.312] Timer tick, asking Buildbucket for the build status
[01:36:36.613] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:36.613] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:55:0) after 1m0s
[01:37:36.707] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:55:0)
[01:37:36.707] Timer tick, asking Buildbucket for the build status
[01:37:36.790] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:36.790] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:56:0) after 1m0s
[01:38:36.825] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:56:0)
[01:38:36.825] Timer tick, asking Buildbucket for the build status
[01:38:36.940] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:36.940] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:57:0) after 1m0s
[01:39:36.958] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:57:0)
[01:39:36.958] Timer tick, asking Buildbucket for the build status
[01:39:37.600] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:37.600] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:58:0) after 1m0s
[01:40:37.722] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:58:0)
[01:40:37.722] Timer tick, asking Buildbucket for the build status
[01:40:38.096] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:38.096] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:59:0) after 1m0s
[01:41:38.229] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:59:0)
[01:41:38.229] Timer tick, asking Buildbucket for the build status
[01:41:38.349] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:38.349] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:60:0) after 1m0s
[01:42:38.426] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:60:0)
[01:42:38.426] Timer tick, asking Buildbucket for the build status
[01:42:38.506] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:38.506] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:61:0) after 1m0s
[01:43:38.539] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:61:0)
[01:43:38.539] Timer tick, asking Buildbucket for the build status
[01:43:38.714] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:38.714] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:62:0) after 1m0s
[01:44:38.732] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:62:0)
[01:44:38.732] Timer tick, asking Buildbucket for the build status
[01:44:39.364] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:39.364] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:63:0) after 1m0s
[01:45:39.447] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:63:0)
[01:45:39.447] Timer tick, asking Buildbucket for the build status
[01:45:39.596] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:39.596] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:64:0) after 1m0s
[01:46:39.630] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:64:0)
[01:46:39.630] Timer tick, asking Buildbucket for the build status
[01:46:39.911] Build 8870856452028312048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:39.911] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9036286514097409328:65:0) after 1m0s
[01:47:03.582] Received PubSub notification, asking Buildbucket for the build status
[01:47:03.659] Build 8870856452028312048: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:47:03.659] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1598492820809064",
"created_by": "project:chromium",
"created_ts": "1598489059381642",
"failure_reason": "BUILD_FAILURE",
"id": "8870856452028312048",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"83392f747232d6715966c263e9c9904bada8c888\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('process clang code coverage data for overall test coverage.generate metadata for overall test coverage in 48 tests') (retcode: 1)\"}, \"properties\": {\"$build/code_coverage\": {\"use_clang_coverage\": true}, \"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-2-r22n\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-code-coverage-native\", \"buildnumber\": 8241, \"got_angle_revision\": \"3d1609516687c6040bcfaa2ba94454f102076171\", \"got_dawn_revision\": \"320c6c87b2ed980d4c7622230976d40ad0fc54a1\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"83392f747232d6715966c263e9c9904bada8c888\", \"got_revision_cp\": \"refs/heads/master@{#802046}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"1f48854dae26a2d129ae771e671a2172acb2da86\", \"got_v8_revision\": \"1f2195b49c6d7611165ebd149b2825f27693930c\", \"got_v8_revision_cp\": \"refs/heads/8.7.25@{#1}\", \"got_webrtc_revision\": \"c75c4280763435eeb44785dfc76f098bf06743bb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31999}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"process_coverage_data_failure\": true, \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"83392f747232d6715966c263e9c9904bada8c888\", \"swarm_hashes\": {\"absl_hardening_tests\": \"80c43a6b233cea668e36ad758d05cf6082d5fbcf\", \"android_browsertests\": \"8774e9bbe3be207a52057b9b1b7d3288df044bd2\", \"angle_unittests\": \"c86e5c3b7acb7c8b7637b68fe072da167506a939\", \"base_unittests\": \"d3fa0e5a7be305bbf2598cb48b13e41c9ee5bc40\", \"base_util_unittests\": \"4ce4dec23d76ebcc2a3225080c317e3add3666cf\", \"blink_common_unittests\": \"6791bc50a49c625bde351dd2b8cdb8ca28d8cf02\", \"blink_heap_unittests\": \"8e4a2e2f68a41c4a51a1f865f5d6e92d8600a17c\", \"blink_platform_unittests\": \"bd2d408c4bf19eaba4e7f9714711149351e98fad\", \"boringssl_crypto_tests\": \"cd4e7a5ae2971f454e11966527e8aec9eb2ea1b7\", \"boringssl_ssl_tests\": \"b41d5b0e240f6f054c9aae9b1760d6abf6ff3e25\", \"breakpad_unittests\": \"429bf6623cb2c4b9f5ead77ac5eea6c42d116387\", \"capture_unittests\": \"ee7fa4093aa1595a8de0a3c0ced20fd8c83e5360\", \"cast_unittests\": \"df48f89b580feda6f47ec13e22d855b45bc5fb34\", \"cc_unittests\": \"3a03be9400099e63663bd1b776ad3431dd626507\", \"crypto_unittests\": \"2274fe5fef149127a614104ca08e9b9918bcdb6c\", \"device_unittests\": \"2eafb070f4df99a1f2aa910f01c19b7ff9b70b2c\", \"display_unittests\": \"2623440f6c502078107c905ceb9c4ccf40d98a1d\", \"events_unittests\": \"fab2b4dd03f4c3712220f67cee00cb0b5bf4e9e7\", \"gcm_unit_tests\": \"f92449ac0b4c3058f8213a2b59a01af83e0f221b\", \"gfx_unittests\": \"0ac10820ad52f02042e8e45101889220f1669e7a\", \"gin_unittests\": \"3da6945d30a83466121f7ddb8f5c2a50ea17122e\", \"gl_tests\": \"21ec9acebfadd1ae5c0829e984835b0b6de08eb1\", \"gl_unittests\": \"386e1141b6c70486221248fc41ed7b4d57a62efc\", \"google_apis_unittests\": \"9e2d8906233cd14ba9c9df364fe91ad026e38b05\", \"gpu_unittests\": \"aa4b7d0a31cfdd355d19f06cb483bea20b5de026\", \"gwp_asan_unittests\": \"cf45e44041c898e4439610eb59fc87a19dcc7da1\", \"ipc_tests\": \"df02e3539a1b28f4f9c314d360695e09f1c8f150\", \"jingle_unittests\": \"ebf1882f737231659281f1ffd6ec966b39b38612\", \"latency_unittests\": \"d4f154fb8533db0026061e5f5b9a94d90a953ae5\", \"libjingle_xmpp_unittests\": \"891227190ff22e64842f7812750fe62e94bc8288\", \"media_blink_unittests\": \"d42b2c7a7ead269ca26bd1fd6dbc1aa6db5af3e5\", \"media_unittests\": \"c14afa13243751f13b24071f6fcd30d9d14050ab\", \"midi_unittests\": \"6f5042c109f5b89870a4db231d490e1fc36ccbd4\", \"mojo_test_apk\": \"0c382da0a25b157efa1efec46219e3ab7ee9a25e\", \"mojo_unittests\": \"42450d9140007409a599736dd69865e850fc1b06\", \"net_unittests\": \"e8d4c56b5f57b145b04ef64295de028904440db1\", \"sandbox_linux_unittests\": \"5928f9695576b8e0448db7fe4fa6bb72bf7ae69c\", \"services_unittests\": \"cb567ebec0586b60276f0113595620951425b6cf\", \"shell_dialogs_unittests\": \"2d1f6919113e1b069cfc2e29d3cb095309cf8150\", \"skia_unittests\": \"1c9e18698a3d8f0e14722fa07fa67757cd4b8497\", \"sql_unittests\": \"a1530e0c5d1b7c65f7ac5099b643f544395ebac8\", \"storage_unittests\": \"4f079055959d6f105a2293e2ab31486afaa95cc9\", \"ui_android_unittests\": \"fbef53055f9202d9509ff9c2d11f30818ca4510f\", \"ui_base_unittests\": \"94112b69961ae0632af39ac4289924545a4c08c8\", \"ui_touch_selection_unittests\": \"4014a8343c2e38b4bc07311d8daf8019201a5445\", \"url_unittests\": \"4b9c466228f63b46882accb52112decf2d56582d\", \"viz_unittests\": \"dd0b7f1889c11febb93a73bbdccc1666100744e3\", \"wtf_unittests\": \"605205ffa6c62daeeab0828cf9d74d7b7100df3a\"}, \"swarm_hashes_refs/heads/master(at){#802046}_without_patch\": {\"absl_hardening_tests\": \"80c43a6b233cea668e36ad758d05cf6082d5fbcf\", \"android_browsertests\": \"8774e9bbe3be207a52057b9b1b7d3288df044bd2\", \"angle_unittests\": \"c86e5c3b7acb7c8b7637b68fe072da167506a939\", \"base_unittests\": \"d3fa0e5a7be305bbf2598cb48b13e41c9ee5bc40\", \"base_util_unittests\": \"4ce4dec23d76ebcc2a3225080c317e3add3666cf\", \"blink_common_unittests\": \"6791bc50a49c625bde351dd2b8cdb8ca28d8cf02\", \"blink_heap_unittests\": \"8e4a2e2f68a41c4a51a1f865f5d6e92d8600a17c\", \"blink_platform_unittests\": \"bd2d408c4bf19eaba4e7f9714711149351e98fad\", \"boringssl_crypto_tests\": \"cd4e7a5ae2971f454e11966527e8aec9eb2ea1b7\", \"boringssl_ssl_tests\": \"b41d5b0e240f6f054c9aae9b1760d6abf6ff3e25\", \"breakpad_unittests\": \"429bf6623cb2c4b9f5ead77ac5eea6c42d116387\", \"capture_unittests\": \"ee7fa4093aa1595a8de0a3c0ced20fd8c83e5360\", \"cast_unittests\": \"df48f89b580feda6f47ec13e22d855b45bc5fb34\", \"cc_unittests\": \"3a03be9400099e63663bd1b776ad3431dd626507\", \"crypto_unittests\": \"2274fe5fef149127a614104ca08e9b9918bcdb6c\", \"device_unittests\": \"2eafb070f4df99a1f2aa910f01c19b7ff9b70b2c\", \"display_unittests\": \"2623440f6c502078107c905ceb9c4ccf40d98a1d\", \"events_unittests\": \"fab2b4dd03f4c3712220f67cee00cb0b5bf4e9e7\", \"gcm_unit_tests\": \"f92449ac0b4c3058f8213a2b59a01af83e0f221b\", \"gfx_unittests\": \"0ac10820ad52f02042e8e45101889220f1669e7a\", \"gin_unittests\": \"3da6945d30a83466121f7ddb8f5c2a50ea17122e\", \"gl_tests\": \"21ec9acebfadd1ae5c0829e984835b0b6de08eb1\", \"gl_unittests\": \"386e1141b6c70486221248fc41ed7b4d57a62efc\", \"google_apis_unittests\": \"9e2d8906233cd14ba9c9df364fe91ad026e38b05\", \"gpu_unittests\": \"aa4b7d0a31cfdd355d19f06cb483bea20b5de026\", \"gwp_asan_unittests\": \"cf45e44041c898e4439610eb59fc87a19dcc7da1\", \"ipc_tests\": \"df02e3539a1b28f4f9c314d360695e09f1c8f150\", \"jingle_unittests\": \"ebf1882f737231659281f1ffd6ec966b39b38612\", \"latency_unittests\": \"d4f154fb8533db0026061e5f5b9a94d90a953ae5\", \"libjingle_xmpp_unittests\": \"891227190ff22e64842f7812750fe62e94bc8288\", \"media_blink_unittests\": \"d42b2c7a7ead269ca26bd1fd6dbc1aa6db5af3e5\", \"media_unittests\": \"c14afa13243751f13b24071f6fcd30d9d14050ab\", \"midi_unittests\": \"6f5042c109f5b89870a4db231d490e1fc36ccbd4\", \"mojo_test_apk\": \"0c382da0a25b157efa1efec46219e3ab7ee9a25e\", \"mojo_unittests\": \"42450d9140007409a599736dd69865e850fc1b06\", \"net_unittests\": \"e8d4c56b5f57b145b04ef64295de028904440db1\", \"sandbox_linux_unittests\": \"5928f9695576b8e0448db7fe4fa6bb72bf7ae69c\", \"services_unittests\": \"cb567ebec0586b60276f0113595620951425b6cf\", \"shell_dialogs_unittests\": \"2d1f6919113e1b069cfc2e29d3cb095309cf8150\", \"skia_unittests\": \"1c9e18698a3d8f0e14722fa07fa67757cd4b8497\", \"sql_unittests\": \"a1530e0c5d1b7c65f7ac5099b643f544395ebac8\", \"storage_unittests\": \"4f079055959d6f105a2293e2ab31486afaa95cc9\", \"ui_android_unittests\": \"fbef53055f9202d9509ff9c2d11f30818ca4510f\", \"ui_base_unittests\": \"94112b69961ae0632af39ac4289924545a4c08c8\", \"ui_touch_selection_unittests\": \"4014a8343c2e38b4bc07311d8daf8019201a5445\", \"url_unittests\": \"4b9c466228f63b46882accb52112decf2d56582d\", \"viz_unittests\": \"dd0b7f1889c11febb93a73bbdccc1666100744e3\", \"wtf_unittests\": \"605205ffa6c62daeeab0828cf9d74d7b7100df3a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_84527c5af4d4441fc5a14374d256be65769803505d9e2e72cad7cb7913806658_v2\", \"builder_f0e85433ca60e21ba10033b857841d88af052436c6cb8411b561ff60a2c00a4a_v2\", \"builder_f2ac5903ab08ee4ddab389becac92d3a3647f6b791038f1abef5b06a03e08513_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-c-600-ssd-hm32-2-r22n\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-highmem-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5498-3454aa6\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}, \"ui\": {\"info\": \"Step('process clang code coverage data for overall test coverage.generate metadata for overall test coverage in 48 tests') (retcode: 1)\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1598489098452029",
"status": "COMPLETED",
"status_changed_ts": "1598489098930334",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/8241",
"builder:android-code-coverage-native",
"buildset:commit/git/83392f747232d6715966c263e9c9904bada8c888",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/83392f747232d6715966c263e9c9904bada8c888",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036286514097409328",
"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/8870856452028312048/+/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:4e4630ec4864a610",
"user_agent:luci-scheduler"
],
"updated_ts": "1598492822205342",
"url": "https://ci.chromium.org/b/8870856452028312048",
"utcnow_ts": "1598492823650694"
}
}
[01:47:03.659] Invocation finished in 1h2m45.634926268s with status FAILED