[17:46:20.812] New invocation is queued and will start shortly
[17:46:21.953] Starting the invocation (attempt 1)
[17:46:21.998] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:46:21.998] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:46:21.998] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028430873402993232",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d77a28bd0f3698e80a2ab6d73d4ec847196cceef\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028430873402993232",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/d77a28bd0f3698e80a2ab6d73d4ec847196cceef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d77a28bd0f3698e80a2ab6d73d4ec847196cceef",
"gitiles_ref:refs/heads/master"
]
}
[17:46:23.207] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605980782143766",
"id": "8863000811341625184",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d77a28bd0f3698e80a2ab6d73d4ec847196cceef\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605980783068708",
"tags": [
"build_address:luci.chromium.ci/win-asan/15764",
"builder:win-asan",
"buildset:commit/git/d77a28bd0f3698e80a2ab6d73d4ec847196cceef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d77a28bd0f3698e80a2ab6d73d4ec847196cceef",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028430873402993232",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8863000811341625184/+/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": "1605980783068819",
"url": "https://ci.chromium.org/b/8863000811341625184",
"utcnow_ts": "1605980783199276"
}
}
[17:46:23.207] Task URL: https://ci.chromium.org/b/8863000811341625184
[17:46:23.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:2:0) after 1m0s
[17:46:26.847] Received PubSub notification, asking Buildbucket for the build status
[17:46:26.960] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:23.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:2:0)
[17:47:23.216] Timer tick, asking Buildbucket for the build status
[17:47:23.316] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:23.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:4:0) after 1m0s
[17:48:23.357] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:4:0)
[17:48:23.357] Timer tick, asking Buildbucket for the build status
[17:48:23.468] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:23.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:5:0) after 1m0s
[17:49:23.518] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:5:0)
[17:49:23.518] Timer tick, asking Buildbucket for the build status
[17:49:23.680] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:23.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:6:0) after 1m0s
[17:50:23.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:6:0)
[17:50:23.677] Timer tick, asking Buildbucket for the build status
[17:50:23.795] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:23.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:7:0) after 1m0s
[17:51:23.817] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:7:0)
[17:51:23.817] Timer tick, asking Buildbucket for the build status
[17:51:23.926] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:23.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:8:0) after 1m0s
[17:52:24.095] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:8:0)
[17:52:24.095] Timer tick, asking Buildbucket for the build status
[17:52:24.294] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:24.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:9:0) after 1m0s
[17:53:24.345] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:9:0)
[17:53:24.345] Timer tick, asking Buildbucket for the build status
[17:53:24.407] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:24.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:10:0) after 1m0s
[17:54:24.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:10:0)
[17:54:24.428] Timer tick, asking Buildbucket for the build status
[17:54:24.497] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:24.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:11:0) after 1m0s
[17:55:24.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:11:0)
[17:55:24.520] Timer tick, asking Buildbucket for the build status
[17:55:24.640] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:24.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:12:0) after 1m0s
[17:56:24.724] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:12:0)
[17:56:24.724] Timer tick, asking Buildbucket for the build status
[17:56:24.838] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:24.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:13:0) after 1m0s
[17:57:24.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:13:0)
[17:57:24.925] Timer tick, asking Buildbucket for the build status
[17:57:24.988] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:24.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:14:0) after 1m0s
[17:58:25.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:14:0)
[17:58:25.008] Timer tick, asking Buildbucket for the build status
[17:58:25.263] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:25.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:15:0) after 1m0s
[17:59:25.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:15:0)
[17:59:25.354] Timer tick, asking Buildbucket for the build status
[17:59:25.522] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:25.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:16:0) after 1m0s
[18:00:25.503] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:16:0)
[18:00:25.503] Timer tick, asking Buildbucket for the build status
[18:00:25.639] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:25.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:17:0) after 1m0s
[18:01:25.734] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:17:0)
[18:01:25.734] Timer tick, asking Buildbucket for the build status
[18:01:25.842] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:25.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:18:0) after 1m0s
[18:02:25.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:18:0)
[18:02:25.831] Timer tick, asking Buildbucket for the build status
[18:02:26.052] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:26.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:19:0) after 1m0s
[18:03:26.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:19:0)
[18:03:26.087] Timer tick, asking Buildbucket for the build status
[18:03:26.230] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:26.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:20:0) after 1m0s
[18:04:26.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:20:0)
[18:04:26.260] Timer tick, asking Buildbucket for the build status
[18:04:26.417] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:26.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:21:0) after 1m0s
[18:05:26.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:21:0)
[18:05:26.445] Timer tick, asking Buildbucket for the build status
[18:05:26.571] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:26.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:22:0) after 1m0s
[18:06:26.625] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:22:0)
[18:06:26.625] Timer tick, asking Buildbucket for the build status
[18:06:26.736] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:26.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:23:0) after 1m0s
[18:07:26.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:23:0)
[18:07:26.792] Timer tick, asking Buildbucket for the build status
[18:07:26.884] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:26.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:24:0) after 1m0s
[18:08:26.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:24:0)
[18:08:26.909] Timer tick, asking Buildbucket for the build status
[18:08:27.282] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:27.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:25:0) after 1m0s
[18:09:27.316] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:25:0)
[18:09:27.316] Timer tick, asking Buildbucket for the build status
[18:09:27.440] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:27.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:26:0) after 1m0s
[18:10:27.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:26:0)
[18:10:27.459] Timer tick, asking Buildbucket for the build status
[18:10:27.572] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:27.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:27:0) after 1m0s
[18:11:27.644] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:27:0)
[18:11:27.644] Timer tick, asking Buildbucket for the build status
[18:11:27.772] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:27.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:28:0) after 1m0s
[18:12:27.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:28:0)
[18:12:27.775] Timer tick, asking Buildbucket for the build status
[18:12:28.370] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:28.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:29:0) after 1m0s
[18:13:28.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:29:0)
[18:13:28.388] Timer tick, asking Buildbucket for the build status
[18:13:28.521] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:28.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:30:0) after 1m0s
[18:14:28.565] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:30:0)
[18:14:28.565] Timer tick, asking Buildbucket for the build status
[18:14:28.642] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:28.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:31:0) after 1m0s
[18:15:28.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:31:0)
[18:15:28.654] Timer tick, asking Buildbucket for the build status
[18:15:28.792] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:28.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:32:0) after 1m0s
[18:16:28.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:32:0)
[18:16:28.777] Timer tick, asking Buildbucket for the build status
[18:16:28.898] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:28.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:33:0) after 1m0s
[18:17:28.944] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:33:0)
[18:17:28.944] Timer tick, asking Buildbucket for the build status
[18:17:29.111] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:29.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:34:0) after 1m0s
[18:18:29.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:34:0)
[18:18:29.147] Timer tick, asking Buildbucket for the build status
[18:18:29.298] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:29.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:35:0) after 1m0s
[18:19:29.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:35:0)
[18:19:29.291] Timer tick, asking Buildbucket for the build status
[18:19:29.382] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:29.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:36:0) after 1m0s
[18:20:29.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:36:0)
[18:20:29.445] Timer tick, asking Buildbucket for the build status
[18:20:29.567] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:29.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:37:0) after 1m0s
[18:21:29.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:37:0)
[18:21:29.619] Timer tick, asking Buildbucket for the build status
[18:21:29.743] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:29.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:38:0) after 1m0s
[18:22:29.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:38:0)
[18:22:29.732] Timer tick, asking Buildbucket for the build status
[18:22:29.819] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:29.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:39:0) after 1m0s
[18:23:29.890] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:39:0)
[18:23:29.890] Timer tick, asking Buildbucket for the build status
[18:23:29.968] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:29.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:40:0) after 1m0s
[18:24:30.040] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:40:0)
[18:24:30.040] Timer tick, asking Buildbucket for the build status
[18:24:30.127] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:30.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:41:0) after 1m0s
[18:25:30.175] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:41:0)
[18:25:30.175] Timer tick, asking Buildbucket for the build status
[18:25:30.443] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:30.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:42:0) after 1m0s
[18:26:30.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:42:0)
[18:26:30.507] Timer tick, asking Buildbucket for the build status
[18:26:31.316] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:31.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:43:0) after 1m0s
[18:27:31.385] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:43:0)
[18:27:31.386] Timer tick, asking Buildbucket for the build status
[18:27:31.557] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:31.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:44:0) after 1m0s
[18:28:31.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:44:0)
[18:28:31.591] Timer tick, asking Buildbucket for the build status
[18:28:31.669] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:31.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:45:0) after 1m0s
[18:29:31.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:45:0)
[18:29:31.697] Timer tick, asking Buildbucket for the build status
[18:29:32.105] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:32.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:46:0) after 1m0s
[18:30:32.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:46:0)
[18:30:32.174] Timer tick, asking Buildbucket for the build status
[18:30:32.267] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:32.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:47:0) after 1m0s
[18:31:32.279] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:47:0)
[18:31:32.280] Timer tick, asking Buildbucket for the build status
[18:31:32.401] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:32.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:48:0) after 1m0s
[18:32:32.500] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:48:0)
[18:32:32.500] Timer tick, asking Buildbucket for the build status
[18:32:32.623] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:32.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:49:0) after 1m0s
[18:33:32.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:49:0)
[18:33:32.692] Timer tick, asking Buildbucket for the build status
[18:33:32.829] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:32.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:50:0) after 1m0s
[18:34:32.851] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:50:0)
[18:34:32.851] Timer tick, asking Buildbucket for the build status
[18:34:33.004] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:33.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:51:0) after 1m0s
[18:35:33.026] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:51:0)
[18:35:33.026] Timer tick, asking Buildbucket for the build status
[18:35:33.148] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:33.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:52:0) after 1m0s
[18:36:33.181] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:52:0)
[18:36:33.181] Timer tick, asking Buildbucket for the build status
[18:36:33.397] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:33.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:53:0) after 1m0s
[18:37:33.401] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:53:0)
[18:37:33.401] Timer tick, asking Buildbucket for the build status
[18:37:33.520] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:33.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:54:0) after 1m0s
[18:38:33.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:54:0)
[18:38:33.558] Timer tick, asking Buildbucket for the build status
[18:38:33.688] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:33.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:55:0) after 1m0s
[18:39:33.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:55:0)
[18:39:33.711] Timer tick, asking Buildbucket for the build status
[18:39:33.794] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:33.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:56:0) after 1m0s
[18:40:33.816] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:56:0)
[18:40:33.816] Timer tick, asking Buildbucket for the build status
[18:40:34.227] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:34.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:57:0) after 1m0s
[18:41:34.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:57:0)
[18:41:34.282] Timer tick, asking Buildbucket for the build status
[18:41:34.588] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:34.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:58:0) after 1m0s
[18:42:34.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:58:0)
[18:42:34.615] Timer tick, asking Buildbucket for the build status
[18:42:35.853] Build 8863000811341625184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:35.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028430873402993232:59:0) after 1m0s
[18:43:05.379] Received PubSub notification, asking Buildbucket for the build status
[18:43:05.469] Build 8863000811341625184: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:43:05.469] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605984182917404",
"created_by": "project:chromium",
"created_ts": "1605980782143766",
"failure_reason": "BUILD_FAILURE",
"id": "8863000811341625184",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d77a28bd0f3698e80a2ab6d73d4ec847196cceef\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**gcp_unittests** failed.\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"d77a28bd0f3698e80a2ab6d73d4ec847196cceef\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-3-xoby\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15764, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"e51c9068a84f14e42157c097eb764ec3009e0e54\", \"got_dawn_revision\": \"41b3f9c1e4aaaa3d56d205d81e61deaebdd40d75\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"d77a28bd0f3698e80a2ab6d73d4ec847196cceef\", \"got_revision_cp\": \"refs/heads/master@{#829997}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"22f2e5ef66ed5c820532f27b141096d3ddb1966e\", \"got_v8_revision_cp\": \"refs/heads/8.9.31@{#1}\", \"got_webrtc_revision\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d77a28bd0f3698e80a2ab6d73d4ec847196cceef\", \"swarm_hashes_refs/heads/master(at){#829997}_without_patch\": {\"absl_hardening_tests\": \"03f8cf3a2f4169627e0ed28ba69c5c84c44e9bca\", \"accessibility_unittests\": \"fb53dc171b0a719d0aab3c657cd47e0319bf9b4f\", \"angle_unittests\": \"61d00a2ca7432bf2f24d1cfe2e38adfe0b5dada6\", \"app_shell_unittests\": \"2af00cde0fa388c0a9a1dd55c8afd1517cfbfe1c\", \"aura_unittests\": \"7f3e44ec9a4f08c3446356586239fe6c4c54fe35\", \"base_unittests\": \"3fa0baf0323929317c0d01e7bdc2ba86f540b31a\", \"base_util_unittests\": \"812836bc6dd6835f64320125857ead7b6fcb58da\", \"blink_common_unittests\": \"adc22442737a39f7feb1177029deaec9c9f16104\", \"blink_fuzzer_unittests\": \"2a263181914dff76aad9e834388beec9d70cf158\", \"blink_heap_unittests\": \"b294e8893d416465bf3b2fbfec08638cb0d337c4\", \"blink_platform_unittests\": \"0faf563c5c558cf0c9b32d068f619632c3c07c66\", \"blink_unittests\": \"b26c049a2aad5ca0e2d1f15bad83ca110cc85d36\", \"boringssl_crypto_tests\": \"437c75175903f17674a9426a491631b4128312e4\", \"boringssl_ssl_tests\": \"f4ff432e1af43e5acb487de694833bb9c814729b\", \"browser_switcher_bho_unittests\": \"919516cdd26c2924eef5e801aba557510c19e98d\", \"browser_tests\": \"1a1095af5fee074c341d9c07d12eda10be346248\", \"capture_unittests\": \"c59e2862d479d275ee14875e0b1361cda16f9131\", \"cast_unittests\": \"2e81114622f67db4173bd0819448ed199add6ea0\", \"cc_unittests\": \"d42a98bbc33f8d3965b854c372205943f0863ebf\", \"chrome_app_unittests\": \"b006ce67e26db7c9ab310d876993b6fcc140152a\", \"chrome_cleaner_unittests\": \"7b80ca66f96ea4228110f27f40ec6928a7e0c0ca\", \"chrome_elf_unittests\": \"8c94ee72ef68da23705db3e7d4571a98f9316f1f\", \"chromedriver_unittests\": \"96e899b088a99a5aa4d799bf9266090a36ce1115\", \"components_browsertests\": \"52a70d0ecbaf1643f2103b9eddb7fbb656ef51ac\", \"components_unittests\": \"37b74d83f88bb6de5106ccd29b476b8864da9135\", \"compositor_unittests\": \"d5129f93580bd6a52c4b28e7323051035dc05ab4\", \"content_browsertests\": \"7140be6084386f78fa4e165e9af2b48efd85f6a6\", \"content_unittests\": \"207b5e1c865b87fb263a0002105afb18ac15645c\", \"courgette_unittests\": \"a17f5074c9c443370901ebbd313a73fad4f2232d\", \"crashpad_tests\": \"2fa8caccdc442fd1d58e8af08fc7595ed23482c8\", \"cronet_tests\": \"64a1a87b84d94ba28aa36b43e4349cb99bb90ceb\", \"cronet_unittests\": \"77db119592d5c1ef68e9c029cfddd9430a31f9f6\", \"crypto_unittests\": \"3da2dbc00740440fb318d4c7ff7565d884f2c7d4\", \"delayloads_unittests\": \"fabce54433cfe876abb04ed3161bf6f0cd59bb23\", \"device_unittests\": \"b20cb146188d38e07c7cbb4f78a75f7536254792\", \"display_unittests\": \"0e7859cfabf5c929767bb12e87ee08954c1ffd2f\", \"elevation_service_unittests\": \"2512a250108e7a968ecae8e634876932abb5745c\", \"events_unittests\": \"15216aaf8975385acca07773566d8205a09513d6\", \"extensions_browsertests\": \"3605d36050f0898b0c1fbb9703b7854b8faded1b\", \"extensions_unittests\": \"156b67b0786b991682e669c3da5f84c45e3e2839\", \"filesystem_service_unittests\": \"fdac573d1382394d2f151c6d3bfbeb63e15a0cc3\", \"gcm_unit_tests\": \"f57052a52de0643e7f742d3751f42fd1513c1717\", \"gcp_unittests\": \"df3c47a58bb482cf9b1a5c5042f042cd6af743af\", \"gfx_unittests\": \"d4ca301da81f9aae8f2a17134575b0de28a7955a\", \"gin_unittests\": \"f3c145ba478a44a5a280790d3f2f8f22aa41d9e1\", \"google_apis_unittests\": \"8f85a3448b172e3a4a8e47a1bea93f3abbf09a66\", \"gpu_unittests\": \"600b8d882b615314b56fa3dd8ea9e11a4f966058\", \"gwp_asan_unittests\": \"d089adbe34f9eb3581284df92e7c9b9cae7bf80e\", \"headless_browsertests\": \"30bc34ea60fdfc92c362f448a44dfc94bcd14f54\", \"headless_unittests\": \"461e4cd0231962bb60f676f4da0f0d4230944fe6\", \"install_static_unittests\": \"2edf1b7d23afcb4022d3824355ed553468a3e500\", \"installer_util_unittests\": \"62198903fd66cb5bb372bd12e2771d94098f29d2\", \"interactive_ui_tests\": \"4c3c47db95e3a1dc054a760e27ffb25ea8d0a664\", \"ipc_tests\": \"8a91f2ffb2683809f4c32af4109fa87e6e4cee65\", \"jingle_unittests\": \"c724bb89720f07bd799734ae38f279747592896d\", \"latency_unittests\": \"1104431caf1173a54aa4a519a628abb607982b19\", \"libjingle_xmpp_unittests\": \"572ece09f722d4c605e3b5329e22992e71ddf109\", \"liburlpattern_unittests\": \"4d9b160b32a730f6228271723d31ba3533ea8a90\", \"media_blink_unittests\": \"f7b96d261cb61c9b2e82c553e2b4f7206f903298\", \"media_unittests\": \"beafab018506e52496a18445730b1a92300f4e1b\", \"message_center_unittests\": \"ae97a484f5b257d320074647f185f438175d5fc0\", \"midi_unittests\": \"d1c87dca65125232d5addd6c538d49aa18b2b6dc\", \"mojo_core_unittests\": \"475f21aeb586ace23eee0c18ba22b4aafbea0bc3\", \"mojo_unittests\": \"95fe0fda746f2a7fb6ae4eee22844ad6975ec159\", \"nacl_loader_unittests\": \"cdb5ba9dd1906fc3015f463ef81bbb1079867160\", \"native_theme_unittests\": \"ca5738b52eba8b510209eb143e06c9c2b0991998\", \"net_unittests\": \"3cd506f18c18a86a4994dbfe009d8c251640b384\", \"notification_helper_unittests\": \"2add27b891738147d3a4d766b74112c3f8c2d74a\", \"pdf_unittests\": \"5e30f5261d4e9403a52eea84f05177459e3244a5\", \"perfetto_unittests\": \"82bd99ddee7719e34966774e38dc3b74958506d3\", \"ppapi_unittests\": \"da99c3159c5fc243f5f6de5b2e8f974c6213739b\", \"printing_unittests\": \"9f1492dfd85b14a4c1274e914e554430dd6e94a2\", \"remoting_unittests\": \"4483a6fa7ae3f22b904af6f1f85412396bd22150\", \"sbox_integration_tests\": \"e6bd515c87268308824a2c219974ac6df2d152d1\", \"sbox_unittests\": \"fb25190ce879ae23856e8fa9ec2df388ea4a81f0\", \"sbox_validation_tests\": \"73711daf6e4bee6a49876d8236a80596d9026575\", \"service_manager_unittests\": \"8a2b0f87cdf0eae2fd15ba3d92035ea7cf208c55\", \"services_unittests\": \"22fc9a4339ee1ca661f6fe74b466ee87faebdfda\", \"setup_unittests\": \"bb2ca24c54cac58f02caed9ef369d2f3543b6eb8\", \"shell_dialogs_unittests\": \"0c3e6c82a3ab78a4b9bd98385581b735936f9cbe\", \"skia_unittests\": \"23f518601809eec29f28ebf03b115857d16e4f55\", \"snapshot_unittests\": \"e04ae10d0e16b101dc24d6bbdb50df90cb781fa1\", \"sql_unittests\": \"b758c138cfee371b392954b82b108423636c39bc\", \"storage_unittests\": \"1e64a290d6a92bb825137fd4cd3a23895bf15394\", \"sync_integration_tests\": \"059422504b9a95a506d605983814fe678c502eda\", \"traffic_annotation_auditor_unittests\": \"f47a08f7c985d97872e41dcc546da1e45a12b3a7\", \"ui_base_unittests\": \"8d9d0c42bc6315fd5f95dc4eb8df2e5174c64a2c\", \"ui_touch_selection_unittests\": \"10dc99cf467af7e1afaa6969936270d1088c431b\", \"unit_tests\": \"a279832bce06b92b3c0e09c4148018c7373e0e0a\", \"updater_tests\": \"af46fca8a796b5165e070a376b41121430321da1\", \"url_unittests\": \"6ad24ee46ed673531cf4d3fba2020f90e7f10499\", \"views_unittests\": \"73c525b19fabe009d7cd60e47d4468379f0fb452\", \"viz_unittests\": \"1dd2bfe1cb1cdda8b730ddb533f2a93de92a5e6f\", \"vr_common_unittests\": \"a41b492ef85d0f7c066d1d88bb44fdd1a619405d\", \"vr_pixeltests\": \"07f35866c594db896776d67e6dfe69687f287d7a\", \"weblayer_browsertests\": \"73052dc11658ac8a671cbab038029e2248ef8bb6\", \"weblayer_unittests\": \"fd333b0fe888658e8743cba1dd80bb7a44321424\", \"wm_unittests\": \"61c952ad5a3d6aa74441fb99a98e4b44b215abf9\", \"wtf_unittests\": \"9b3a592a33ef0bffcaf4d28dc25a9f976daaf642\", \"zlib_unittests\": \"ba6da342d7ae880f9c35d222d5c5daa0c2a982a3\", \"zucchini_unittests\": \"75335a4920051e8a5388fc68fa6c32da0ae47dce\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-3-xoby\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**gcp_unittests** failed.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605980785705601",
"status": "COMPLETED",
"status_changed_ts": "1605980786498621",
"tags": [
"build_address:luci.chromium.ci/win-asan/15764",
"builder:win-asan",
"buildset:commit/git/d77a28bd0f3698e80a2ab6d73d4ec847196cceef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d77a28bd0f3698e80a2ab6d73d4ec847196cceef",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028430873402993232",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8863000811341625184/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:5004bb8bc5600f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605984185057273",
"url": "https://ci.chromium.org/b/8863000811341625184",
"utcnow_ts": "1605984185458998"
}
}
[18:43:05.469] Invocation finished in 56m44.674420921s with status FAILED