[11:42:04.958] New invocation is queued and will start shortly
[11:42:06.041] Starting the invocation (attempt 1)
[11:42:06.075] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:42:06.075] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:42:06.076] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9040684381393584480",
"parameters_json": "{\"builder_name\":\"android-code-coverage-native\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"113bb98d822511d7c58f78a7ccd03152af40b554\"}}",
"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:9040684381393584480",
"scheduler_job_id:chromium/android-code-coverage-native",
"user_agent:luci-scheduler",
"buildset:commit/git/113bb98d822511d7c58f78a7ccd03152af40b554",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/113bb98d822511d7c58f78a7ccd03152af40b554",
"gitiles_ref:refs/heads/master"
]
}
[11:42:07.983] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1594294926312801",
"id": "8875254319305997328",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"113bb98d822511d7c58f78a7ccd03152af40b554\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1594294927458326",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/7814",
"builder:android-code-coverage-native",
"buildset:commit/git/113bb98d822511d7c58f78a7ccd03152af40b554",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/113bb98d822511d7c58f78a7ccd03152af40b554",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040684381393584480",
"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/8875254319305997328/+/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": "1594294927458962",
"url": "https://ci.chromium.org/b/8875254319305997328",
"utcnow_ts": "1594294927909319"
}
}
[11:42:07.983] Task URL: https://ci.chromium.org/b/8875254319305997328
[11:42:07.983] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:2:0) after 1m0s
[11:43:07.985] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:2:0)
[11:43:07.985] Timer tick, asking Buildbucket for the build status
[11:43:08.249] Build 8875254319305997328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:43:08.249] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:3:0) after 1m0s
[11:43:09.001] Received PubSub notification, asking Buildbucket for the build status
[11:43:09.108] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:08.857] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:3:0)
[11:44:08.857] Timer tick, asking Buildbucket for the build status
[11:44:09.163] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:09.163] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:5:0) after 1m0s
[11:45:09.215] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:5:0)
[11:45:09.215] Timer tick, asking Buildbucket for the build status
[11:45:09.527] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:09.527] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:6:0) after 1m0s
[11:46:09.576] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:6:0)
[11:46:09.576] Timer tick, asking Buildbucket for the build status
[11:46:09.741] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:09.741] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:7:0) after 1m0s
[11:47:09.806] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:7:0)
[11:47:09.806] Timer tick, asking Buildbucket for the build status
[11:47:10.190] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:10.190] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:8:0) after 1m0s
[11:48:10.283] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:8:0)
[11:48:10.284] Timer tick, asking Buildbucket for the build status
[11:48:10.477] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:10.477] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:9:0) after 1m0s
[11:49:10.502] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:9:0)
[11:49:10.502] Timer tick, asking Buildbucket for the build status
[11:49:11.283] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:11.283] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:10:0) after 1m0s
[11:50:11.962] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:10:0)
[11:50:11.962] Timer tick, asking Buildbucket for the build status
[11:50:12.161] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:12.161] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:11:0) after 1m0s
[11:51:12.258] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:11:0)
[11:51:12.258] Timer tick, asking Buildbucket for the build status
[11:51:12.408] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:12.408] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:12:0) after 1m0s
[11:52:12.677] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:12:0)
[11:52:12.677] Timer tick, asking Buildbucket for the build status
[11:52:12.825] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:12.825] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:13:0) after 1m0s
[11:53:12.908] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:13:0)
[11:53:12.908] Timer tick, asking Buildbucket for the build status
[11:53:13.063] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:13.063] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:14:0) after 1m0s
[11:54:13.223] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:14:0)
[11:54:13.223] Timer tick, asking Buildbucket for the build status
[11:54:13.435] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:13.435] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:15:0) after 1m0s
[11:55:13.612] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:15:0)
[11:55:13.612] Timer tick, asking Buildbucket for the build status
[11:55:13.842] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:13.843] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:16:0) after 1m0s
[11:56:14.078] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:16:0)
[11:56:14.078] Timer tick, asking Buildbucket for the build status
[11:56:14.290] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:14.290] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:17:0) after 1m0s
[11:57:14.419] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:17:0)
[11:57:14.419] Timer tick, asking Buildbucket for the build status
[11:57:14.580] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:14.580] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:18:0) after 1m0s
[11:58:14.826] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:18:0)
[11:58:14.826] Timer tick, asking Buildbucket for the build status
[11:58:15.012] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:15.012] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:19:0) after 1m0s
[11:59:15.234] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:19:0)
[11:59:15.234] Timer tick, asking Buildbucket for the build status
[11:59:15.407] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:15.407] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:20:0) after 1m0s
[12:00:15.479] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:20:0)
[12:00:15.479] Timer tick, asking Buildbucket for the build status
[12:00:15.609] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:15.609] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:21:0) after 1m0s
[12:01:15.678] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:21:0)
[12:01:15.678] Timer tick, asking Buildbucket for the build status
[12:01:15.915] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:15.915] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:22:0) after 1m0s
[12:02:16.022] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:22:0)
[12:02:16.022] Timer tick, asking Buildbucket for the build status
[12:02:16.328] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:16.328] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:23:0) after 1m0s
[12:03:16.668] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:23:0)
[12:03:16.668] Timer tick, asking Buildbucket for the build status
[12:03:17.302] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:17.302] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:24:0) after 1m0s
[12:04:17.336] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:24:0)
[12:04:17.336] Timer tick, asking Buildbucket for the build status
[12:04:18.423] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:18.423] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:25:0) after 1m0s
[12:05:18.596] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:25:0)
[12:05:18.596] Timer tick, asking Buildbucket for the build status
[12:05:18.792] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:18.792] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:26:0) after 1m0s
[12:06:18.869] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:26:0)
[12:06:18.869] Timer tick, asking Buildbucket for the build status
[12:06:19.066] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:19.066] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:27:0) after 1m0s
[12:07:19.241] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:27:0)
[12:07:19.241] Timer tick, asking Buildbucket for the build status
[12:07:19.658] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:19.658] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:28:0) after 1m0s
[12:08:19.753] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:28:0)
[12:08:19.753] Timer tick, asking Buildbucket for the build status
[12:08:20.437] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:20.437] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:29:0) after 1m0s
[12:09:20.565] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:29:0)
[12:09:20.565] Timer tick, asking Buildbucket for the build status
[12:09:20.749] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:20.749] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:30:0) after 1m0s
[12:10:20.923] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:30:0)
[12:10:20.923] Timer tick, asking Buildbucket for the build status
[12:10:21.090] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:21.090] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:31:0) after 1m0s
[12:11:21.281] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:31:0)
[12:11:21.281] Timer tick, asking Buildbucket for the build status
[12:11:21.453] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:21.453] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:32:0) after 1m0s
[12:12:21.680] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:32:0)
[12:12:21.680] Timer tick, asking Buildbucket for the build status
[12:12:25.966] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:25.966] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:33:0) after 1m0s
[12:13:25.994] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:33:0)
[12:13:25.994] Timer tick, asking Buildbucket for the build status
[12:13:26.496] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:26.496] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:34:0) after 1m0s
[12:14:26.697] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:34:0)
[12:14:26.697] Timer tick, asking Buildbucket for the build status
[12:14:26.853] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:26.853] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:35:0) after 1m0s
[12:15:26.874] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:35:0)
[12:15:26.874] Timer tick, asking Buildbucket for the build status
[12:15:27.032] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:27.032] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:36:0) after 1m0s
[12:16:27.137] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:36:0)
[12:16:27.137] Timer tick, asking Buildbucket for the build status
[12:16:27.463] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:27.463] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:37:0) after 1m0s
[12:17:27.492] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:37:0)
[12:17:27.492] Timer tick, asking Buildbucket for the build status
[12:17:27.799] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:27.799] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:38:0) after 1m0s
[12:18:27.850] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:38:0)
[12:18:27.850] Timer tick, asking Buildbucket for the build status
[12:18:28.051] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:28.051] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:39:0) after 1m0s
[12:19:28.119] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:39:0)
[12:19:28.119] Timer tick, asking Buildbucket for the build status
[12:19:29.277] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:29.277] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:40:0) after 1m0s
[12:20:29.326] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:40:0)
[12:20:29.326] Timer tick, asking Buildbucket for the build status
[12:20:29.879] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:29.879] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:41:0) after 1m0s
[12:21:29.937] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:41:0)
[12:21:29.937] Timer tick, asking Buildbucket for the build status
[12:21:30.133] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:30.133] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:42:0) after 1m0s
[12:22:30.162] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:42:0)
[12:22:30.163] Timer tick, asking Buildbucket for the build status
[12:22:30.704] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:30.704] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:43:0) after 1m0s
[12:23:30.793] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:43:0)
[12:23:30.793] Timer tick, asking Buildbucket for the build status
[12:23:30.957] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:30.957] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:44:0) after 1m0s
[12:24:31.074] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:44:0)
[12:24:31.074] Timer tick, asking Buildbucket for the build status
[12:24:31.458] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:31.458] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:45:0) after 1m0s
[12:25:31.619] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:45:0)
[12:25:31.619] Timer tick, asking Buildbucket for the build status
[12:25:31.979] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:31.979] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:46:0) after 1m0s
[12:26:33.041] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:46:0)
[12:26:33.041] Timer tick, asking Buildbucket for the build status
[12:26:33.257] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:33.257] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:47:0) after 1m0s
[12:27:33.432] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:47:0)
[12:27:33.432] Timer tick, asking Buildbucket for the build status
[12:27:33.698] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:33.698] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:48:0) after 1m0s
[12:28:34.000] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:48:0)
[12:28:34.000] Timer tick, asking Buildbucket for the build status
[12:28:34.139] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:34.139] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:49:0) after 1m0s
[12:29:34.310] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:49:0)
[12:29:34.310] Timer tick, asking Buildbucket for the build status
[12:29:34.732] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:34.732] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:50:0) after 1m0s
[12:30:34.779] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:50:0)
[12:30:34.779] Timer tick, asking Buildbucket for the build status
[12:30:34.904] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:34.904] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:51:0) after 1m0s
[12:31:34.968] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:51:0)
[12:31:34.968] Timer tick, asking Buildbucket for the build status
[12:31:35.126] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:35.126] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:52:0) after 1m0s
[12:32:35.473] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:52:0)
[12:32:35.473] Timer tick, asking Buildbucket for the build status
[12:32:35.630] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:35.630] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:53:0) after 1m0s
[12:33:35.895] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:53:0)
[12:33:35.895] Timer tick, asking Buildbucket for the build status
[12:33:36.083] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:36.083] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:54:0) after 1m0s
[12:34:36.106] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:54:0)
[12:34:36.106] Timer tick, asking Buildbucket for the build status
[12:34:36.303] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:36.303] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:55:0) after 1m0s
[12:35:36.447] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:55:0)
[12:35:36.447] Timer tick, asking Buildbucket for the build status
[12:35:36.681] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:36.681] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:56:0) after 1m0s
[12:36:36.713] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:56:0)
[12:36:36.713] Timer tick, asking Buildbucket for the build status
[12:36:36.898] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:36.898] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:57:0) after 1m0s
[12:37:36.928] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:57:0)
[12:37:36.928] Timer tick, asking Buildbucket for the build status
[12:37:37.722] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:37.722] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:58:0) after 1m0s
[12:38:37.964] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:58:0)
[12:38:37.964] Timer tick, asking Buildbucket for the build status
[12:38:38.129] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:38.129] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:59:0) after 1m0s
[12:39:38.148] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:59:0)
[12:39:38.148] Timer tick, asking Buildbucket for the build status
[12:39:38.297] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:38.297] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:60:0) after 1m0s
[12:40:38.364] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:60:0)
[12:40:38.364] Timer tick, asking Buildbucket for the build status
[12:40:38.977] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:38.977] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:61:0) after 1m0s
[12:41:39.033] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:61:0)
[12:41:39.033] Timer tick, asking Buildbucket for the build status
[12:41:39.193] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:39.193] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:62:0) after 1m0s
[12:42:39.260] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:62:0)
[12:42:39.260] Timer tick, asking Buildbucket for the build status
[12:42:39.656] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:39.656] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:63:0) after 1m0s
[12:43:39.682] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:63:0)
[12:43:39.682] Timer tick, asking Buildbucket for the build status
[12:43:39.900] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:39.900] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:64:0) after 1m0s
[12:44:39.926] Handling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:64:0)
[12:44:39.926] Timer tick, asking Buildbucket for the build status
[12:44:40.075] Build 8875254319305997328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:40.075] Scheduling timer "check-buildbucket-build-status" (chromium/android-code-coverage-native:9040684381393584480:65:0) after 1m0s
[12:44:52.810] Received PubSub notification, asking Buildbucket for the build status
[12:44:52.992] Build 8875254319305997328: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:44:52.992] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1594298691402561",
"created_by": "project:chromium",
"created_ts": "1594294926312801",
"failure_reason": "BUILD_FAILURE",
"id": "8875254319305997328",
"parameters_json": "{\"builder_name\": \"android-code-coverage-native\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"113bb98d822511d7c58f78a7ccd03152af40b554\"}}",
"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-0-3nt2\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-code-coverage-native\", \"buildnumber\": 7814, \"got_angle_revision\": \"900c7e87ce707c081af72b51a5d08049a65c2fb8\", \"got_dawn_revision\": \"8a9919980f5417cd3df6e1bf6d9a3dc53762ad18\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"113bb98d822511d7c58f78a7ccd03152af40b554\", \"got_revision_cp\": \"refs/heads/master@{#786695}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"76cae97fc14cc95fb446335e2f70501f4ecc066c\", \"got_v8_revision\": \"e078f1d43a5ef91a701f1686917b6fac5176be85\", \"got_v8_revision_cp\": \"refs/heads/8.6.82@{#1}\", \"got_webrtc_revision\": \"18523c34b464600540b4b1f042d0d5519a5be953\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31682}\", \"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\": \"113bb98d822511d7c58f78a7ccd03152af40b554\", \"swarm_hashes\": {\"absl_hardening_tests\": \"e72649705bf6c26890094129c1be7cb224f31204\", \"android_browsertests\": \"a17e0e5db130007ba34aa0fe723bf4885cd14db2\", \"angle_unittests\": \"a7bd737f167a59d60aeb77aa22e842ba324d055c\", \"base_unittests\": \"a0818481bb8d07e0da5c265357013beeb5db8dc4\", \"base_util_unittests\": \"4f4f2cf009ad7ddeb200df80e6c1b27cf76edb6e\", \"blink_common_unittests\": \"0d28a1c5d6cfcaf56ca9293a530aa2aab5a43a14\", \"blink_heap_unittests\": \"76066daa56b96cfa295adecde0e631925afdce47\", \"blink_platform_unittests\": \"efb8489c091e2ca134ea12cd3c0f13a2c5a1563e\", \"boringssl_crypto_tests\": \"d39e482b6a09e1f8959767f156b6a3931827fea3\", \"boringssl_ssl_tests\": \"cde5b29e3781bd358546d00bcc627b34940fd162\", \"breakpad_unittests\": \"3a02cc4af2483c6345d6ab8d600dda3e710d8dd5\", \"capture_unittests\": \"c6e28b11c7d25123f328be124d3aa01527c6aa5b\", \"cast_unittests\": \"e105d8753267eb05f4268462c0143df1e75cf309\", \"cc_unittests\": \"b9be3ea8564ea43c78edcab73e05e77f5583bb03\", \"crypto_unittests\": \"96039337ec9a7dbdaa7f6f5c2a6dded777eb0f21\", \"device_unittests\": \"b08138191c6cf32fe859e97c03a5468f0e9cde58\", \"display_unittests\": \"79f6a0869ed6ad6c70679b6b1e00f78677c9283e\", \"events_unittests\": \"f0a8fe6b492ffd20e0736f18f6a42edcc44d873b\", \"gcm_unit_tests\": \"51a58c34609ce41c9293e93ca72e1f8d5a0fc368\", \"gfx_unittests\": \"265318245d5e81c6ccfc13a94c2de53c491156fb\", \"gin_unittests\": \"a0f1abfff0cea3864a48bfe0476e9d781051e2af\", \"gl_tests\": \"00884aab5fee1330226e41449ee0f70af66eb404\", \"gl_unittests\": \"8dfe83f4299f797fc6cbf34a122c99ec8f6b4204\", \"google_apis_unittests\": \"873fda4bd9a6bbdf08ffb3d3fd785784b5e71aea\", \"gpu_unittests\": \"aa0b90fdab450c9bb53bafff1baa8be6ba9035b7\", \"gwp_asan_unittests\": \"e5c3b7bca951b1a08c6e1dbcc953c0fc22bc2f74\", \"ipc_tests\": \"d68ffd02635083e59a3263fbc0e021592b146b0e\", \"jingle_unittests\": \"1eb745586b53e769395f1ac8131f6500bc177b22\", \"latency_unittests\": \"44eedffa24b8ffac0c9e61041021223ef533a487\", \"libjingle_xmpp_unittests\": \"cabcea8f68fc9416d72ef17ecbbaf764daa10f8b\", \"media_blink_unittests\": \"54586e82ad095304fee4959b7454efcb58fa3074\", \"media_unittests\": \"9e8f7ef391e1240bcffa1d16467ec027fcb82e9e\", \"midi_unittests\": \"3348e721268ab7c284171fcef52eac84fc3e0df6\", \"mojo_test_apk\": \"b8d19535218206c56762d6c8766cd5afd2ae0fb5\", \"mojo_unittests\": \"d818c31bd503259dd746eba8f4a5e94ec5859b7a\", \"net_unittests\": \"21c3e3462d4112be69a4d7cbd7d7a2a668cf9fcf\", \"sandbox_linux_unittests\": \"79969693e3c2c2171b51f59811a393de3f230695\", \"services_unittests\": \"d9e2e1a62ca067f59d46320cf62f844b784390ba\", \"shell_dialogs_unittests\": \"86e689da99cafc5cb2cd80b7413b21bd1d99b4cb\", \"skia_unittests\": \"a8f738255d281becced4acb6e5ac4435f6a5225c\", \"sql_unittests\": \"2b9c94b215d084f481bb0902180e6b47d7561a13\", \"storage_unittests\": \"e1db361d9e05ce98d8e278e89f33267190bbb887\", \"ui_android_unittests\": \"d972d35aada3486a9952ea88bd341e6c7eace143\", \"ui_base_unittests\": \"29d177779e1f279d0ccf3ab96e09dc1d6560a45a\", \"ui_touch_selection_unittests\": \"3e7368792c68f4b1ab74c2f9455bb2942eeb9b85\", \"url_unittests\": \"7982472aa6a0fa4db647825bd461f87af0db1aa8\", \"viz_unittests\": \"0cffaa457add3c76b42fdee3b4b71368050ad142\", \"wtf_unittests\": \"72ecd1b315b68f75ba46d964289ba6cadf9693ab\"}, \"swarm_hashes_refs/heads/master(at){#786695}_without_patch\": {\"absl_hardening_tests\": \"e72649705bf6c26890094129c1be7cb224f31204\", \"android_browsertests\": \"a17e0e5db130007ba34aa0fe723bf4885cd14db2\", \"angle_unittests\": \"a7bd737f167a59d60aeb77aa22e842ba324d055c\", \"base_unittests\": \"a0818481bb8d07e0da5c265357013beeb5db8dc4\", \"base_util_unittests\": \"4f4f2cf009ad7ddeb200df80e6c1b27cf76edb6e\", \"blink_common_unittests\": \"0d28a1c5d6cfcaf56ca9293a530aa2aab5a43a14\", \"blink_heap_unittests\": \"76066daa56b96cfa295adecde0e631925afdce47\", \"blink_platform_unittests\": \"efb8489c091e2ca134ea12cd3c0f13a2c5a1563e\", \"boringssl_crypto_tests\": \"d39e482b6a09e1f8959767f156b6a3931827fea3\", \"boringssl_ssl_tests\": \"cde5b29e3781bd358546d00bcc627b34940fd162\", \"breakpad_unittests\": \"3a02cc4af2483c6345d6ab8d600dda3e710d8dd5\", \"capture_unittests\": \"c6e28b11c7d25123f328be124d3aa01527c6aa5b\", \"cast_unittests\": \"e105d8753267eb05f4268462c0143df1e75cf309\", \"cc_unittests\": \"b9be3ea8564ea43c78edcab73e05e77f5583bb03\", \"crypto_unittests\": \"96039337ec9a7dbdaa7f6f5c2a6dded777eb0f21\", \"device_unittests\": \"b08138191c6cf32fe859e97c03a5468f0e9cde58\", \"display_unittests\": \"79f6a0869ed6ad6c70679b6b1e00f78677c9283e\", \"events_unittests\": \"f0a8fe6b492ffd20e0736f18f6a42edcc44d873b\", \"gcm_unit_tests\": \"51a58c34609ce41c9293e93ca72e1f8d5a0fc368\", \"gfx_unittests\": \"265318245d5e81c6ccfc13a94c2de53c491156fb\", \"gin_unittests\": \"a0f1abfff0cea3864a48bfe0476e9d781051e2af\", \"gl_tests\": \"00884aab5fee1330226e41449ee0f70af66eb404\", \"gl_unittests\": \"8dfe83f4299f797fc6cbf34a122c99ec8f6b4204\", \"google_apis_unittests\": \"873fda4bd9a6bbdf08ffb3d3fd785784b5e71aea\", \"gpu_unittests\": \"aa0b90fdab450c9bb53bafff1baa8be6ba9035b7\", \"gwp_asan_unittests\": \"e5c3b7bca951b1a08c6e1dbcc953c0fc22bc2f74\", \"ipc_tests\": \"d68ffd02635083e59a3263fbc0e021592b146b0e\", \"jingle_unittests\": \"1eb745586b53e769395f1ac8131f6500bc177b22\", \"latency_unittests\": \"44eedffa24b8ffac0c9e61041021223ef533a487\", \"libjingle_xmpp_unittests\": \"cabcea8f68fc9416d72ef17ecbbaf764daa10f8b\", \"media_blink_unittests\": \"54586e82ad095304fee4959b7454efcb58fa3074\", \"media_unittests\": \"9e8f7ef391e1240bcffa1d16467ec027fcb82e9e\", \"midi_unittests\": \"3348e721268ab7c284171fcef52eac84fc3e0df6\", \"mojo_test_apk\": \"b8d19535218206c56762d6c8766cd5afd2ae0fb5\", \"mojo_unittests\": \"d818c31bd503259dd746eba8f4a5e94ec5859b7a\", \"net_unittests\": \"21c3e3462d4112be69a4d7cbd7d7a2a668cf9fcf\", \"sandbox_linux_unittests\": \"79969693e3c2c2171b51f59811a393de3f230695\", \"services_unittests\": \"d9e2e1a62ca067f59d46320cf62f844b784390ba\", \"shell_dialogs_unittests\": \"86e689da99cafc5cb2cd80b7413b21bd1d99b4cb\", \"skia_unittests\": \"a8f738255d281becced4acb6e5ac4435f6a5225c\", \"sql_unittests\": \"2b9c94b215d084f481bb0902180e6b47d7561a13\", \"storage_unittests\": \"e1db361d9e05ce98d8e278e89f33267190bbb887\", \"ui_android_unittests\": \"d972d35aada3486a9952ea88bd341e6c7eace143\", \"ui_base_unittests\": \"29d177779e1f279d0ccf3ab96e09dc1d6560a45a\", \"ui_touch_selection_unittests\": \"3e7368792c68f4b1ab74c2f9455bb2942eeb9b85\", \"url_unittests\": \"7982472aa6a0fa4db647825bd461f87af0db1aa8\", \"viz_unittests\": \"0cffaa457add3c76b42fdee3b4b71368050ad142\", \"wtf_unittests\": \"72ecd1b315b68f75ba46d964289ba6cadf9693ab\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1cf5addf4d1b07dee05bb817410abedd1ddd14dde2cca1baf3f95933882f5cfd_v2\", \"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-0-3nt2\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"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\": [\"5378-e275056\"], \"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": "1594294987872303",
"status": "COMPLETED",
"status_changed_ts": "1594294988664879",
"tags": [
"build_address:luci.chromium.ci/android-code-coverage-native/7814",
"builder:android-code-coverage-native",
"buildset:commit/git/113bb98d822511d7c58f78a7ccd03152af40b554",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/113bb98d822511d7c58f78a7ccd03152af40b554",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040684381393584480",
"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/8875254319305997328/+/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:4d4c338a9807f910",
"user_agent:luci-scheduler"
],
"updated_ts": "1594298692166623",
"url": "https://ci.chromium.org/b/8875254319305997328",
"utcnow_ts": "1594298692980946"
}
}
[12:44:52.992] Invocation finished in 1h2m48.054822822s with status FAILED