[21:28:28.751] New invocation is queued and will start shortly
[21:28:30.375] Starting the invocation (attempt 1)
[21:28:30.417] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:28:30.417] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:28:30.417] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030138240407082144",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ae840aee772110901fe05ae8105a24b145d8daf1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9030138240407082144",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/ae840aee772110901fe05ae8105a24b145d8daf1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ae840aee772110901fe05ae8105a24b145d8daf1",
"gitiles_ref:refs/heads/master"
]
}
[21:28:32.361] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604352511479213",
"id": "8864708176881382480",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ae840aee772110901fe05ae8105a24b145d8daf1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604352512204904",
"tags": [
"build_address:luci.chromium.ci/win-asan/15421",
"builder:win-asan",
"buildset:commit/git/ae840aee772110901fe05ae8105a24b145d8daf1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ae840aee772110901fe05ae8105a24b145d8daf1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030138240407082144",
"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/8864708176881382480/+/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": "1604352512205012",
"url": "https://ci.chromium.org/b/8864708176881382480",
"utcnow_ts": "1604352512351560"
}
}
[21:28:32.361] Task URL: https://ci.chromium.org/b/8864708176881382480
[21:28:32.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:2:0) after 1m0s
[21:29:32.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:2:0)
[21:29:32.413] Timer tick, asking Buildbucket for the build status
[21:29:32.591] Build 8864708176881382480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:29:32.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:3:0) after 1m0s
[21:30:32.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:3:0)
[21:30:32.650] Timer tick, asking Buildbucket for the build status
[21:30:32.808] Build 8864708176881382480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:30:32.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:4:0) after 1m0s
[21:31:27.301] Received PubSub notification, asking Buildbucket for the build status
[21:31:27.377] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:32.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:4:0)
[21:31:32.887] Timer tick, asking Buildbucket for the build status
[21:31:33.189] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:33.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:6:0) after 1m0s
[21:32:33.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:6:0)
[21:32:33.255] Timer tick, asking Buildbucket for the build status
[21:32:33.374] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:33.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:7:0) after 1m0s
[21:33:33.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:7:0)
[21:33:33.444] Timer tick, asking Buildbucket for the build status
[21:33:33.713] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:33.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:8:0) after 1m0s
[21:34:33.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:8:0)
[21:34:33.856] Timer tick, asking Buildbucket for the build status
[21:34:33.922] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:33.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:9:0) after 1m0s
[21:35:34.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:9:0)
[21:35:34.015] Timer tick, asking Buildbucket for the build status
[21:35:34.083] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:34.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:10:0) after 1m0s
[21:36:34.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:10:0)
[21:36:34.107] Timer tick, asking Buildbucket for the build status
[21:36:34.161] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:34.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:11:0) after 1m0s
[21:37:34.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:11:0)
[21:37:34.270] Timer tick, asking Buildbucket for the build status
[21:37:34.341] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:34.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:12:0) after 1m0s
[21:38:34.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:12:0)
[21:38:34.444] Timer tick, asking Buildbucket for the build status
[21:38:34.550] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:34.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:13:0) after 1m0s
[21:39:34.723] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:13:0)
[21:39:34.723] Timer tick, asking Buildbucket for the build status
[21:39:34.916] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:34.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:14:0) after 1m0s
[21:40:35.041] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:14:0)
[21:40:35.041] Timer tick, asking Buildbucket for the build status
[21:40:35.316] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:35.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:15:0) after 1m0s
[21:41:35.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:15:0)
[21:41:35.798] Timer tick, asking Buildbucket for the build status
[21:41:36.470] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:36.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:16:0) after 1m0s
[21:42:36.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:16:0)
[21:42:36.685] Timer tick, asking Buildbucket for the build status
[21:42:36.810] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:36.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:17:0) after 1m0s
[21:43:37.034] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:17:0)
[21:43:37.034] Timer tick, asking Buildbucket for the build status
[21:43:37.350] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:37.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:18:0) after 1m0s
[21:44:37.509] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:18:0)
[21:44:37.509] Timer tick, asking Buildbucket for the build status
[21:44:37.625] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:37.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:19:0) after 1m0s
[21:45:37.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:19:0)
[21:45:37.657] Timer tick, asking Buildbucket for the build status
[21:45:37.728] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:37.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:20:0) after 1m0s
[21:46:37.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:20:0)
[21:46:37.875] Timer tick, asking Buildbucket for the build status
[21:46:37.936] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:37.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:21:0) after 1m0s
[21:47:38.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:21:0)
[21:47:38.094] Timer tick, asking Buildbucket for the build status
[21:47:38.260] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:38.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:22:0) after 1m0s
[21:48:38.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:22:0)
[21:48:38.283] Timer tick, asking Buildbucket for the build status
[21:48:38.497] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:38.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:23:0) after 1m0s
[21:49:38.653] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:23:0)
[21:49:38.653] Timer tick, asking Buildbucket for the build status
[21:49:38.892] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:38.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:24:0) after 1m0s
[21:50:38.974] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:24:0)
[21:50:38.974] Timer tick, asking Buildbucket for the build status
[21:50:39.063] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:39.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:25:0) after 1m0s
[21:51:39.102] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:25:0)
[21:51:39.102] Timer tick, asking Buildbucket for the build status
[21:51:39.387] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:39.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:26:0) after 1m0s
[21:52:39.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:26:0)
[21:52:39.461] Timer tick, asking Buildbucket for the build status
[21:52:39.545] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:39.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:27:0) after 1m0s
[21:53:39.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:27:0)
[21:53:39.633] Timer tick, asking Buildbucket for the build status
[21:53:39.764] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:39.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:28:0) after 1m0s
[21:54:39.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:28:0)
[21:54:39.865] Timer tick, asking Buildbucket for the build status
[21:54:39.925] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:39.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:29:0) after 1m0s
[21:55:40.022] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:29:0)
[21:55:40.022] Timer tick, asking Buildbucket for the build status
[21:55:40.390] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:40.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:30:0) after 1m0s
[21:56:40.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:30:0)
[21:56:40.455] Timer tick, asking Buildbucket for the build status
[21:56:40.533] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:40.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:31:0) after 1m0s
[21:57:40.554] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:31:0)
[21:57:40.554] Timer tick, asking Buildbucket for the build status
[21:57:40.621] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:40.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:32:0) after 1m0s
[21:58:40.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:32:0)
[21:58:40.697] Timer tick, asking Buildbucket for the build status
[21:58:40.818] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:40.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:33:0) after 1m0s
[21:59:40.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:33:0)
[21:59:40.844] Timer tick, asking Buildbucket for the build status
[21:59:41.013] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:41.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:34:0) after 1m0s
[22:00:41.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:34:0)
[22:00:41.057] Timer tick, asking Buildbucket for the build status
[22:00:41.136] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:41.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:35:0) after 1m0s
[22:01:41.145] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:35:0)
[22:01:41.145] Timer tick, asking Buildbucket for the build status
[22:01:41.314] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:41.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:36:0) after 1m0s
[22:02:41.560] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:36:0)
[22:02:41.560] Timer tick, asking Buildbucket for the build status
[22:02:44.193] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:44.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:37:0) after 1m0s
[22:03:44.199] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:37:0)
[22:03:44.200] Timer tick, asking Buildbucket for the build status
[22:03:44.313] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:44.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:38:0) after 1m0s
[22:04:44.355] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:38:0)
[22:04:44.355] Timer tick, asking Buildbucket for the build status
[22:04:44.441] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:44.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:39:0) after 1m0s
[22:05:44.458] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:39:0)
[22:05:44.458] Timer tick, asking Buildbucket for the build status
[22:05:44.548] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:44.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:40:0) after 1m0s
[22:06:44.648] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:40:0)
[22:06:44.648] Timer tick, asking Buildbucket for the build status
[22:06:44.755] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:44.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:41:0) after 1m0s
[22:07:44.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:41:0)
[22:07:44.837] Timer tick, asking Buildbucket for the build status
[22:07:45.043] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:45.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:42:0) after 1m0s
[22:08:45.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:42:0)
[22:08:45.226] Timer tick, asking Buildbucket for the build status
[22:08:45.425] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:45.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:43:0) after 1m0s
[22:09:45.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:43:0)
[22:09:45.662] Timer tick, asking Buildbucket for the build status
[22:09:45.729] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:45.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:44:0) after 1m0s
[22:10:45.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:44:0)
[22:10:45.774] Timer tick, asking Buildbucket for the build status
[22:10:45.973] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:45.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:45:0) after 1m0s
[22:11:46.018] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:45:0)
[22:11:46.018] Timer tick, asking Buildbucket for the build status
[22:11:46.140] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:46.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:46:0) after 1m0s
[22:12:46.221] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:46:0)
[22:12:46.221] Timer tick, asking Buildbucket for the build status
[22:12:46.278] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:46.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:47:0) after 1m0s
[22:13:46.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:47:0)
[22:13:46.372] Timer tick, asking Buildbucket for the build status
[22:13:46.831] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:46.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:48:0) after 1m0s
[22:14:46.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:48:0)
[22:14:46.874] Timer tick, asking Buildbucket for the build status
[22:14:46.957] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:46.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:49:0) after 1m0s
[22:15:47.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:49:0)
[22:15:47.010] Timer tick, asking Buildbucket for the build status
[22:15:47.225] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:47.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:50:0) after 1m0s
[22:16:47.236] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:50:0)
[22:16:47.236] Timer tick, asking Buildbucket for the build status
[22:16:47.319] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:47.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:51:0) after 1m0s
[22:17:47.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:51:0)
[22:17:47.365] Timer tick, asking Buildbucket for the build status
[22:17:47.432] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:47.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:52:0) after 1m0s
[22:18:47.406] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:52:0)
[22:18:47.406] Timer tick, asking Buildbucket for the build status
[22:18:47.514] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:47.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:53:0) after 1m0s
[22:19:47.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:53:0)
[22:19:47.552] Timer tick, asking Buildbucket for the build status
[22:19:47.689] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:47.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:54:0) after 1m0s
[22:20:47.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:54:0)
[22:20:47.694] Timer tick, asking Buildbucket for the build status
[22:20:47.840] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:47.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:55:0) after 1m0s
[22:21:47.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:55:0)
[22:21:47.862] Timer tick, asking Buildbucket for the build status
[22:21:47.930] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:47.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:56:0) after 1m0s
[22:22:47.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:56:0)
[22:22:47.971] Timer tick, asking Buildbucket for the build status
[22:22:48.077] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:48.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:57:0) after 1m0s
[22:23:48.103] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:57:0)
[22:23:48.103] Timer tick, asking Buildbucket for the build status
[22:23:48.237] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:48.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:58:0) after 1m0s
[22:24:48.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:58:0)
[22:24:48.283] Timer tick, asking Buildbucket for the build status
[22:24:48.704] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:48.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:59:0) after 1m0s
[22:25:48.773] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:59:0)
[22:25:48.774] Timer tick, asking Buildbucket for the build status
[22:25:48.899] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:48.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:60:0) after 1m0s
[22:26:48.950] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:60:0)
[22:26:48.950] Timer tick, asking Buildbucket for the build status
[22:26:49.079] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:49.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:61:0) after 1m0s
[22:27:49.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:61:0)
[22:27:49.118] Timer tick, asking Buildbucket for the build status
[22:27:49.175] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:49.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:62:0) after 1m0s
[22:28:49.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:62:0)
[22:28:49.163] Timer tick, asking Buildbucket for the build status
[22:28:49.262] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:49.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:63:0) after 1m0s
[22:29:49.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:63:0)
[22:29:49.365] Timer tick, asking Buildbucket for the build status
[22:29:49.477] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:49.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:64:0) after 1m0s
[22:30:49.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:64:0)
[22:30:49.678] Timer tick, asking Buildbucket for the build status
[22:30:49.858] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:49.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:65:0) after 1m0s
[22:31:49.903] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:65:0)
[22:31:49.903] Timer tick, asking Buildbucket for the build status
[22:31:50.013] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:50.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:66:0) after 1m0s
[22:32:50.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:66:0)
[22:32:50.032] Timer tick, asking Buildbucket for the build status
[22:32:50.316] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:50.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:67:0) after 1m0s
[22:33:50.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:67:0)
[22:33:50.359] Timer tick, asking Buildbucket for the build status
[22:33:50.713] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:50.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:68:0) after 1m0s
[22:34:50.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:68:0)
[22:34:50.762] Timer tick, asking Buildbucket for the build status
[22:34:50.881] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:50.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:69:0) after 1m0s
[22:35:50.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:69:0)
[22:35:50.923] Timer tick, asking Buildbucket for the build status
[22:35:51.038] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:51.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:70:0) after 1m0s
[22:36:51.187] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:70:0)
[22:36:51.187] Timer tick, asking Buildbucket for the build status
[22:36:51.315] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:51.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:71:0) after 1m0s
[22:37:51.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:71:0)
[22:37:51.772] Timer tick, asking Buildbucket for the build status
[22:37:51.893] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:51.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:72:0) after 1m0s
[22:38:52.156] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:72:0)
[22:38:52.156] Timer tick, asking Buildbucket for the build status
[22:38:52.288] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:52.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:73:0) after 1m0s
[22:39:52.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:73:0)
[22:39:52.512] Timer tick, asking Buildbucket for the build status
[22:39:52.636] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:52.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:74:0) after 1m0s
[22:40:52.879] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:74:0)
[22:40:52.879] Timer tick, asking Buildbucket for the build status
[22:40:53.131] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:53.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:75:0) after 1m0s
[22:41:53.189] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:75:0)
[22:41:53.189] Timer tick, asking Buildbucket for the build status
[22:41:53.599] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:53.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:76:0) after 1m0s
[22:42:53.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:76:0)
[22:42:53.714] Timer tick, asking Buildbucket for the build status
[22:42:53.787] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:53.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:77:0) after 1m0s
[22:43:53.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:77:0)
[22:43:53.856] Timer tick, asking Buildbucket for the build status
[22:43:54.568] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:54.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:78:0) after 1m0s
[22:44:54.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:78:0)
[22:44:54.591] Timer tick, asking Buildbucket for the build status
[22:44:54.724] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:54.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:79:0) after 1m0s
[22:45:54.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:79:0)
[22:45:54.751] Timer tick, asking Buildbucket for the build status
[22:45:55.339] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:55.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:80:0) after 1m0s
[22:46:55.443] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:80:0)
[22:46:55.443] Timer tick, asking Buildbucket for the build status
[22:46:55.900] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:55.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:81:0) after 1m0s
[22:47:56.643] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:81:0)
[22:47:56.643] Timer tick, asking Buildbucket for the build status
[22:47:57.004] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:57.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:82:0) after 1m0s
[22:48:57.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:82:0)
[22:48:57.461] Timer tick, asking Buildbucket for the build status
[22:48:57.596] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:57.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:83:0) after 1m0s
[22:49:57.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:83:0)
[22:49:57.689] Timer tick, asking Buildbucket for the build status
[22:49:57.777] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:57.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:84:0) after 1m0s
[22:50:57.970] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:84:0)
[22:50:57.970] Timer tick, asking Buildbucket for the build status
[22:50:58.185] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:58.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:85:0) after 1m0s
[22:51:58.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:85:0)
[22:51:58.209] Timer tick, asking Buildbucket for the build status
[22:51:58.857] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:58.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:86:0) after 1m0s
[22:52:58.911] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:86:0)
[22:52:58.911] Timer tick, asking Buildbucket for the build status
[22:52:58.980] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:58.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:87:0) after 1m0s
[22:53:59.104] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:87:0)
[22:53:59.104] Timer tick, asking Buildbucket for the build status
[22:53:59.282] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:59.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:88:0) after 1m0s
[22:54:59.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:88:0)
[22:54:59.336] Timer tick, asking Buildbucket for the build status
[22:54:59.471] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:59.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:89:0) after 1m0s
[22:55:59.509] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:89:0)
[22:55:59.509] Timer tick, asking Buildbucket for the build status
[22:55:59.628] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:59.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:90:0) after 1m0s
[22:56:59.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:90:0)
[22:56:59.662] Timer tick, asking Buildbucket for the build status
[22:56:59.792] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:59.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:91:0) after 1m0s
[22:57:59.842] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:91:0)
[22:57:59.842] Timer tick, asking Buildbucket for the build status
[22:57:59.960] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:59.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:92:0) after 1m0s
[22:59:00.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:92:0)
[22:59:00.006] Timer tick, asking Buildbucket for the build status
[22:59:00.422] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:00.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:93:0) after 1m0s
[23:00:00.443] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:93:0)
[23:00:00.443] Timer tick, asking Buildbucket for the build status
[23:00:00.627] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:00.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:94:0) after 1m0s
[23:01:00.625] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:94:0)
[23:01:00.625] Timer tick, asking Buildbucket for the build status
[23:01:00.729] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:00.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:95:0) after 1m0s
[23:02:00.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:95:0)
[23:02:00.762] Timer tick, asking Buildbucket for the build status
[23:02:00.883] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:00.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:96:0) after 1m0s
[23:03:01.858] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:96:0)
[23:03:01.858] Timer tick, asking Buildbucket for the build status
[23:03:01.927] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:01.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:97:0) after 1m0s
[23:04:02.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:97:0)
[23:04:02.056] Timer tick, asking Buildbucket for the build status
[23:04:02.186] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:02.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:98:0) after 1m0s
[23:05:02.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:98:0)
[23:05:02.652] Timer tick, asking Buildbucket for the build status
[23:05:02.857] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:02.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:99:0) after 1m0s
[23:06:02.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:99:0)
[23:06:02.902] Timer tick, asking Buildbucket for the build status
[23:06:03.214] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:03.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:100:0) after 1m0s
[23:07:03.439] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:100:0)
[23:07:03.439] Timer tick, asking Buildbucket for the build status
[23:07:03.646] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:03.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:101:0) after 1m0s
[23:08:03.733] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:101:0)
[23:08:03.733] Timer tick, asking Buildbucket for the build status
[23:08:04.172] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:04.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:102:0) after 1m0s
[23:09:04.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:102:0)
[23:09:04.211] Timer tick, asking Buildbucket for the build status
[23:09:04.458] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:04.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:103:0) after 1m0s
[23:10:04.482] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:103:0)
[23:10:04.482] Timer tick, asking Buildbucket for the build status
[23:10:04.635] Build 8864708176881382480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:04.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030138240407082144:104:0) after 1m0s
[23:11:01.386] Received PubSub notification, asking Buildbucket for the build status
[23:11:01.465] Build 8864708176881382480: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:11:01.465] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604358660784151",
"created_by": "project:chromium",
"created_ts": "1604352511479213",
"failure_reason": "BUILD_FAILURE",
"id": "8864708176881382480",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ae840aee772110901fe05ae8105a24b145d8daf1\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**base_unittests** failed because of:\\n\\n- EtwTraceConsumerRealtimeTest.ConsumerReturnsWhenSessionClosed\"}, \"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\": \"ae840aee772110901fe05ae8105a24b145d8daf1\", \"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-5-vrjs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15421, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-3\", \"got_angle_revision\": \"ed916ddf61cc0021cebf55fb6901ba71fe9e6a2e\", \"got_dawn_revision\": \"71d2e1d23d49c3616209dbf4776fd720aaa11560\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"ae840aee772110901fe05ae8105a24b145d8daf1\", \"got_revision_cp\": \"refs/heads/master@{#823296}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"b0e426fcf95534d1bbba97b046437bbdf3cfd5b4\", \"got_v8_revision\": \"fcca1a5101d5185549432a342e9ea90a3aad600f\", \"got_v8_revision_cp\": \"refs/heads/8.8.216@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ae840aee772110901fe05ae8105a24b145d8daf1\", \"swarm_hashes_refs/heads/master(at){#823296}_without_patch\": {\"absl_hardening_tests\": \"95d67d8b5a64c128ac401bce287fea90f1af3b74\", \"accessibility_unittests\": \"7059d569da6dc90cbc19662d278b8ad22be1ff65\", \"angle_unittests\": \"6b85ba16d6d67afdffec21a8c20406ed181b78f7\", \"app_shell_unittests\": \"ce469c2384303b27ec38ff095445d019d8b36fa6\", \"aura_unittests\": \"f9188ec082da60fcc8e258c5331024f7271027f1\", \"base_unittests\": \"1f5add0b50add0148cef5e986b962535e2237428\", \"base_util_unittests\": \"5a952c71c5f0a3aedc458fe78247524e5528a29e\", \"blink_common_unittests\": \"4665261f6dc9f21b0bed74dd3d3d06c65315e2b5\", \"blink_fuzzer_unittests\": \"5141ce579a0e59fe62fee330089d5894d44e5b72\", \"blink_heap_unittests\": \"67c672a2b72227fb41cb6e24e97aadf9f25b052f\", \"blink_platform_unittests\": \"afed3113596a5f2b601710a159a01084f97f66b5\", \"blink_unittests\": \"22ba9b15f50f1142582619b9a26ca4e9b57cb8ab\", \"boringssl_crypto_tests\": \"5bb3ea805db6dd12b4fe3f3f4058872a1d82288e\", \"boringssl_ssl_tests\": \"e28b85f4962cfcc1b40640f706c7090231d129da\", \"browser_switcher_bho_unittests\": \"2d7aa37823deb8e99d340be6d8e0367937d607ba\", \"browser_tests\": \"e3cd397c742b42490fd5b596e3c8c8b20ef4a7ef\", \"capture_unittests\": \"5f0cf8f31be36f069cdccc80fd8ef2fe3ddcf98c\", \"cast_unittests\": \"62c921de45861465477946485ed5e305ed335f96\", \"cc_unittests\": \"1804baea82408b4d270475eab64ebf457d71d18b\", \"chrome_app_unittests\": \"cc35d8dbdbd0427f7719aa6175bd1f8942d7726b\", \"chrome_cleaner_unittests\": \"cef5b1493152704cd3d88ac3bb0c7d6242b4692e\", \"chrome_elf_unittests\": \"7614fcd54d157a0a14a16c05b452348be60f8b89\", \"chromedriver_unittests\": \"9ccf5715e4ab5dce7a6edde4dffcca739142fa82\", \"components_browsertests\": \"7ced3b83cf212116e30841c8a249fcda53ebffd1\", \"components_unittests\": \"f377b3b2bc8a4ab533e4b68be5386d4c8128425e\", \"compositor_unittests\": \"ca13d8c6c0c4c5a58d0291f7d8dc9348f7d45ef2\", \"content_browsertests\": \"15aa3bbe46797a79fc50231727715be1ea5f7c36\", \"content_unittests\": \"d188ad6a1126905835ab923429808d54c38d77de\", \"courgette_unittests\": \"8afcbc4b0262b85719d311c1df78e0a1786f6189\", \"crashpad_tests\": \"87c6a3fe72ad5cdb49c84c0403579e10e445211e\", \"cronet_tests\": \"5e3c576cc1120e948e245a1617cb49505b6a6fd5\", \"cronet_unittests\": \"cf8b5000789e8a7c33c3353070964c410f294295\", \"crypto_unittests\": \"0497734add9c757cda7fab9bad0d03ccb6b08e7b\", \"delayloads_unittests\": \"f458ded90615f6ecf83dbcd7d1fd87f5b91928f2\", \"device_unittests\": \"73324cb2ea27bb22317526314b87966e0c6c699e\", \"display_unittests\": \"c53d5390cc7306dd59ebee1b2af38192006fbdec\", \"elevation_service_unittests\": \"50d5284555214b553e64b64b027d910d41f92377\", \"events_unittests\": \"d4573965e768d8eb1d88f64ee4f104f2322b318f\", \"extensions_browsertests\": \"dcb6485c3848ea3cdac99a4568ee537e8ac8d479\", \"extensions_unittests\": \"95d675261eb2d7464b17124ac81cb70637084bd7\", \"filesystem_service_unittests\": \"9038e4dbb7028b83cfce6afe96cb2a1ab328e4da\", \"gcm_unit_tests\": \"a902d3a5c2124049a281fae5adcdd786ae73f5ca\", \"gcp_unittests\": \"ae06edbc1d015488459712207b9a88563037daf8\", \"gfx_unittests\": \"4351ecd2a8e20bc0261de4ea0900c21a7e5de41b\", \"gin_unittests\": \"e9a96bb4f0fc5a332df32e37e1848bd19097f7fe\", \"google_apis_unittests\": \"7a86f044998fed8bb6e692c5562c7e2940c9b7d9\", \"gpu_unittests\": \"e79c9c3b5c8375b87ba69e771338c5b5a5a131a5\", \"gwp_asan_unittests\": \"bb68a3f392ac686c089de562835c04e70c144a30\", \"headless_browsertests\": \"8fa5de22ed211d54f15cbdcebe030f40e589cdc2\", \"headless_unittests\": \"c5381f6c90efbbeb5eaa96f21cd38bdf66e6d9b8\", \"install_static_unittests\": \"b9bc45655a98fd574f354feaa53ddb0ac56c11ce\", \"installer_util_unittests\": \"73f092fce8d20dd52b115212cd2ee576279f2008\", \"interactive_ui_tests\": \"558e005ddf008bdbad699774674163ebcf817b1d\", \"ipc_tests\": \"e096ca8550e948acad02b96356f46926f5f394d8\", \"jingle_unittests\": \"a62937d6e97aa4b2055e565194ed79849e7581a0\", \"latency_unittests\": \"cda4099ee1879e42850a24bd2e4442a3483d2a37\", \"libjingle_xmpp_unittests\": \"d63a21386f9e255f05d2ca0d2a46253ba41d373b\", \"liburlpattern_unittests\": \"6b9b0fbf40a328f45e6299f08ce219866ebbd71c\", \"media_blink_unittests\": \"4d53203cd2b95596a9dbe55585cc9e51b43c3fa3\", \"media_unittests\": \"87b2820efa659a02861bae5428ccf1f955f1f84b\", \"message_center_unittests\": \"4cc98d4c5bb82685c73119c6dfb4490f84fddde8\", \"midi_unittests\": \"f0f86673c369165c90fd3015594fdb93311c9d36\", \"mojo_core_unittests\": \"1b5a666928dbf3c052083ca38a86bc058a98c3a4\", \"mojo_unittests\": \"a25871c9195dcd90893b21710ac8c0184998e0f9\", \"nacl_loader_unittests\": \"d5a642cec7794124ae343cebff9e586355100fd1\", \"native_theme_unittests\": \"53d11dcbb0f2a8d83be9f034a5250f8134b6c383\", \"net_unittests\": \"240a5379f111b53ad0031bb7e8790ce245e0ff7b\", \"notification_helper_unittests\": \"be69052f0c71ba476f93683dec71c1c24521c890\", \"pdf_unittests\": \"f54db83fbc8dee2a5e1dadab572db1f1510ebb79\", \"perfetto_unittests\": \"fb481b14b3999724b9e979bbf07be90a987d922b\", \"ppapi_unittests\": \"d9eaa4543a889cc33d858776ab75a0c5f359533f\", \"printing_unittests\": \"c37d58bf26f5787720f76754be56523a17214ca8\", \"remoting_unittests\": \"5a8a0bda6f6da9f1d9e160ef087b104a04b7ae77\", \"sbox_integration_tests\": \"9d4cb890d5e8e23d313f1f01961e457a730ff4d7\", \"sbox_unittests\": \"0f9e923853d1c2df604a925ad4a0d3c024ea4d15\", \"sbox_validation_tests\": \"f25433828a10743a843ce882418ee6871d05c48c\", \"service_manager_unittests\": \"d82352ca2128f21b7448b507f8cab97916ff98b0\", \"services_unittests\": \"c9f7a493dbf82b12f01ecbe04f447e5e24205de2\", \"setup_unittests\": \"271b30eee793cd5fe9b1e7c7b1db1c191e8b1c94\", \"shell_dialogs_unittests\": \"61a3b7717e8614167132f8836b41120354f9d496\", \"skia_unittests\": \"121fb3cd14cbba2ceca653b42a0e1ab77839bbc5\", \"snapshot_unittests\": \"283c6e98de1dc0194600c9582785d9b50cd27033\", \"sql_unittests\": \"03ffc8fdea03dd2dc3ff0e78833ae29955c46fb5\", \"storage_unittests\": \"0505e262cd6aae9bdaba0cb69b4d5e82c75b609f\", \"sync_integration_tests\": \"a54bfdaf5edf90bb9a4e2b3818a256c02981cf8c\", \"traffic_annotation_auditor_unittests\": \"14acf82ecaef72b8a6c0138eac6847fe130f90cf\", \"ui_base_unittests\": \"ad0cfe81a8e2bdd2345b5373f13b62fde5147f9e\", \"ui_touch_selection_unittests\": \"e3625feddf2ed031a5ec54f472ba6287f4996104\", \"unit_tests\": \"7327e0a8f28a152c68bb4c9045b7bdc1e2405849\", \"updater_tests\": \"88d46f62dd12c0bdf12f755b61ac02ed10ed8a24\", \"url_unittests\": \"c8f2328fe459864fda31c670f7567b4c88ba573a\", \"views_unittests\": \"ebf8face83610912052f385c78af0289a0bca5b6\", \"viz_unittests\": \"2144fe58f8e32821c4fdad586345001bb631c835\", \"vr_common_unittests\": \"94ce429ab4fca853a0c04efee08acf2f35eeb26c\", \"vr_pixeltests\": \"c547b634875dd7a76bdc9399982600b2cce369d0\", \"weblayer_browsertests\": \"3dc96a1c6d7f69777ee23b5fd86fcb8e1d395b65\", \"weblayer_unittests\": \"a8e8660506195ddb783201d1d74174c7d666ec0c\", \"wm_unittests\": \"aa0854827390409775e281e96dec0c88d2b2d23e\", \"wtf_unittests\": \"20639e99c33eff9a51ebe29edc14f9f1463251c9\", \"zlib_unittests\": \"6dd5b6783500590eae3b79499e1c9951eaaea47e\", \"zucchini_unittests\": \"906b0d2ff74138c562b40c3a4da352d8ac242608\"}}, \"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-5-vrjs\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**base_unittests** failed because of:\\n\\n- EtwTraceConsumerRealtimeTest.ConsumerReturnsWhenSessionClosed\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604352686790509",
"status": "COMPLETED",
"status_changed_ts": "1604352687142010",
"tags": [
"build_address:luci.chromium.ci/win-asan/15421",
"builder:win-asan",
"buildset:commit/git/ae840aee772110901fe05ae8105a24b145d8daf1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ae840aee772110901fe05ae8105a24b145d8daf1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030138240407082144",
"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/8864708176881382480/+/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:4fa3ae1a1f8b1610",
"user_agent:luci-scheduler"
],
"updated_ts": "1604358661069547",
"url": "https://ci.chromium.org/b/8864708176881382480",
"utcnow_ts": "1604358661454595"
}
}
[23:11:01.465] Invocation finished in 1h42m32.731512708s with status FAILED