[23:36:00.641] New invocation is queued and will start shortly
[23:36:01.843] Starting the invocation (attempt 1)
[23:36:01.911] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:36:01.911] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:36:01.912] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022520071650639392",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5c60c0a35526b5c721e03d49b943c04637d3912d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9022520071650639392",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/5c60c0a35526b5c721e03d49b943c04637d3912d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5c60c0a35526b5c721e03d49b943c04637d3912d",
"gitiles_ref:refs/heads/master"
]
}
[23:36:03.526] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611617762101997",
"id": "8857090009445740144",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5c60c0a35526b5c721e03d49b943c04637d3912d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611617762919212",
"tags": [
"build_address:luci.chromium.ci/win-asan/17011",
"builder:win-asan",
"buildset:commit/git/5c60c0a35526b5c721e03d49b943c04637d3912d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5c60c0a35526b5c721e03d49b943c04637d3912d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022520071650639392",
"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/8857090009445740144/+/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": "1611617762919427",
"url": "https://ci.chromium.org/b/8857090009445740144",
"utcnow_ts": "1611617763277738"
}
}
[23:36:03.526] Task URL: https://ci.chromium.org/b/8857090009445740144
[23:36:03.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:2:0) after 1m0s
[23:37:03.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:2:0)
[23:37:03.568] Timer tick, asking Buildbucket for the build status
[23:37:04.254] Build 8857090009445740144: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:04.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:3:0) after 1m0s
[23:38:04.276] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:3:0)
[23:38:04.276] Timer tick, asking Buildbucket for the build status
[23:38:04.348] Build 8857090009445740144: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:04.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:4:0) after 1m0s
[23:39:04.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:4:0)
[23:39:04.375] Timer tick, asking Buildbucket for the build status
[23:39:04.481] Build 8857090009445740144: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:04.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:5:0) after 1m0s
[23:39:06.367] Received PubSub notification, asking Buildbucket for the build status
[23:39:06.484] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:04.502] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:5:0)
[23:40:04.502] Timer tick, asking Buildbucket for the build status
[23:40:04.787] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:04.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:7:0) after 1m0s
[23:41:04.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:7:0)
[23:41:04.888] Timer tick, asking Buildbucket for the build status
[23:41:05.350] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:05.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:8:0) after 1m0s
[23:42:05.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:8:0)
[23:42:05.453] Timer tick, asking Buildbucket for the build status
[23:42:05.532] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:05.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:9:0) after 1m0s
[23:43:05.554] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:9:0)
[23:43:05.554] Timer tick, asking Buildbucket for the build status
[23:43:06.119] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:06.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:10:0) after 1m0s
[23:44:06.376] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:10:0)
[23:44:06.376] Timer tick, asking Buildbucket for the build status
[23:44:06.464] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:06.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:11:0) after 1m0s
[23:45:06.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:11:0)
[23:45:06.636] Timer tick, asking Buildbucket for the build status
[23:45:06.749] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:06.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:12:0) after 1m0s
[23:46:06.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:12:0)
[23:46:06.895] Timer tick, asking Buildbucket for the build status
[23:46:07.111] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:07.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:13:0) after 1m0s
[23:47:07.222] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:13:0)
[23:47:07.222] Timer tick, asking Buildbucket for the build status
[23:47:07.367] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:07.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:14:0) after 1m0s
[23:48:07.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:14:0)
[23:48:07.886] Timer tick, asking Buildbucket for the build status
[23:48:08.033] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:08.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:15:0) after 1m0s
[23:49:08.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:15:0)
[23:49:08.046] Timer tick, asking Buildbucket for the build status
[23:49:08.523] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:08.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:16:0) after 1m0s
[23:50:08.611] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:16:0)
[23:50:08.611] Timer tick, asking Buildbucket for the build status
[23:50:08.768] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:08.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:17:0) after 1m0s
[23:51:08.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:17:0)
[23:51:08.820] Timer tick, asking Buildbucket for the build status
[23:51:08.928] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:08.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:18:0) after 1m0s
[23:52:08.957] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:18:0)
[23:52:08.957] Timer tick, asking Buildbucket for the build status
[23:52:09.112] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:09.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:19:0) after 1m0s
[23:53:09.142] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:19:0)
[23:53:09.142] Timer tick, asking Buildbucket for the build status
[23:53:12.902] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:12.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:20:0) after 1m0s
[23:54:12.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:20:0)
[23:54:12.923] Timer tick, asking Buildbucket for the build status
[23:54:13.043] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:13.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:21:0) after 1m0s
[23:55:13.052] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:21:0)
[23:55:13.052] Timer tick, asking Buildbucket for the build status
[23:55:13.130] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:13.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:22:0) after 1m0s
[23:56:13.169] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:22:0)
[23:56:13.169] Timer tick, asking Buildbucket for the build status
[23:56:13.272] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:13.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:23:0) after 1m0s
[23:57:13.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:23:0)
[23:57:13.364] Timer tick, asking Buildbucket for the build status
[23:57:13.413] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:13.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:24:0) after 1m0s
[23:58:13.423] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:24:0)
[23:58:13.423] Timer tick, asking Buildbucket for the build status
[23:58:13.756] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:13.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:25:0) after 1m0s
[23:59:13.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:25:0)
[23:59:13.820] Timer tick, asking Buildbucket for the build status
[23:59:14.049] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:14.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:26:0) after 1m0s
[00:00:14.108] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:26:0)
[00:00:14.108] Timer tick, asking Buildbucket for the build status
[00:00:14.205] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:14.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:27:0) after 1m0s
[00:01:14.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:27:0)
[00:01:14.403] Timer tick, asking Buildbucket for the build status
[00:01:14.620] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:14.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:28:0) after 1m0s
[00:02:14.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:28:0)
[00:02:14.641] Timer tick, asking Buildbucket for the build status
[00:02:14.768] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:14.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:29:0) after 1m0s
[00:03:14.781] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:29:0)
[00:03:14.781] Timer tick, asking Buildbucket for the build status
[00:03:15.029] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:15.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:30:0) after 1m0s
[00:04:15.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:30:0)
[00:04:15.135] Timer tick, asking Buildbucket for the build status
[00:04:15.216] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:15.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:31:0) after 1m0s
[00:05:15.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:31:0)
[00:05:15.287] Timer tick, asking Buildbucket for the build status
[00:05:15.561] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:15.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:32:0) after 1m0s
[00:06:15.631] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:32:0)
[00:06:15.631] Timer tick, asking Buildbucket for the build status
[00:06:15.915] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:15.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:33:0) after 1m0s
[00:07:15.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:33:0)
[00:07:15.991] Timer tick, asking Buildbucket for the build status
[00:07:16.166] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:16.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:34:0) after 1m0s
[00:08:16.188] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:34:0)
[00:08:16.188] Timer tick, asking Buildbucket for the build status
[00:08:16.434] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:16.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:35:0) after 1m0s
[00:09:16.460] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:35:0)
[00:09:16.460] Timer tick, asking Buildbucket for the build status
[00:09:16.522] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:16.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:36:0) after 1m0s
[00:10:16.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:36:0)
[00:10:16.547] Timer tick, asking Buildbucket for the build status
[00:10:16.617] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:16.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:37:0) after 1m0s
[00:11:16.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:37:0)
[00:11:16.592] Timer tick, asking Buildbucket for the build status
[00:11:17.860] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:17.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:38:0) after 1m0s
[00:12:17.915] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:38:0)
[00:12:17.915] Timer tick, asking Buildbucket for the build status
[00:12:17.971] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:17.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:39:0) after 1m0s
[00:13:17.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:39:0)
[00:13:17.991] Timer tick, asking Buildbucket for the build status
[00:13:18.054] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:18.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:40:0) after 1m0s
[00:14:18.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:40:0)
[00:14:18.082] Timer tick, asking Buildbucket for the build status
[00:14:18.136] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:18.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:41:0) after 1m0s
[00:15:18.237] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:41:0)
[00:15:18.237] Timer tick, asking Buildbucket for the build status
[00:15:18.655] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:18.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:42:0) after 1m0s
[00:16:18.664] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:42:0)
[00:16:18.664] Timer tick, asking Buildbucket for the build status
[00:16:20.623] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:20.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:43:0) after 1m0s
[00:17:20.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:43:0)
[00:17:20.656] Timer tick, asking Buildbucket for the build status
[00:17:21.232] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:21.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:44:0) after 1m0s
[00:18:21.271] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:44:0)
[00:18:21.271] Timer tick, asking Buildbucket for the build status
[00:18:21.384] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:21.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:45:0) after 1m0s
[00:19:21.417] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:45:0)
[00:19:21.417] Timer tick, asking Buildbucket for the build status
[00:19:21.578] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:21.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:46:0) after 1m0s
[00:20:21.602] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:46:0)
[00:20:21.602] Timer tick, asking Buildbucket for the build status
[00:20:21.660] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:21.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:47:0) after 1m0s
[00:21:21.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:47:0)
[00:21:21.685] Timer tick, asking Buildbucket for the build status
[00:21:21.858] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:21.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:48:0) after 1m0s
[00:22:21.943] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:48:0)
[00:22:21.943] Timer tick, asking Buildbucket for the build status
[00:22:22.003] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:22.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:49:0) after 1m0s
[00:23:21.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:49:0)
[00:23:21.994] Timer tick, asking Buildbucket for the build status
[00:23:22.163] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:22.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:50:0) after 1m0s
[00:24:22.152] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:50:0)
[00:24:22.152] Timer tick, asking Buildbucket for the build status
[00:24:22.238] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:22.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:51:0) after 1m0s
[00:25:22.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:51:0)
[00:25:22.282] Timer tick, asking Buildbucket for the build status
[00:25:22.359] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:22.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:52:0) after 1m0s
[00:26:22.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:52:0)
[00:26:22.431] Timer tick, asking Buildbucket for the build status
[00:26:22.567] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:22.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:53:0) after 1m0s
[00:27:22.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:53:0)
[00:27:22.604] Timer tick, asking Buildbucket for the build status
[00:27:22.710] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:22.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:54:0) after 1m0s
[00:28:22.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:54:0)
[00:28:22.711] Timer tick, asking Buildbucket for the build status
[00:28:22.793] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:22.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:55:0) after 1m0s
[00:29:22.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:55:0)
[00:29:22.897] Timer tick, asking Buildbucket for the build status
[00:29:22.953] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:22.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:56:0) after 1m0s
[00:30:23.028] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:56:0)
[00:30:23.028] Timer tick, asking Buildbucket for the build status
[00:30:23.113] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:23.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:57:0) after 1m0s
[00:31:23.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:57:0)
[00:31:23.218] Timer tick, asking Buildbucket for the build status
[00:31:23.356] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:23.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:58:0) after 1m0s
[00:32:24.458] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:58:0)
[00:32:24.458] Timer tick, asking Buildbucket for the build status
[00:32:24.550] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:24.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:59:0) after 1m0s
[00:33:24.749] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:59:0)
[00:33:24.749] Timer tick, asking Buildbucket for the build status
[00:33:24.851] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:24.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:60:0) after 1m0s
[00:34:24.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:60:0)
[00:34:24.972] Timer tick, asking Buildbucket for the build status
[00:34:25.538] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:25.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:61:0) after 1m0s
[00:35:25.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:61:0)
[00:35:25.826] Timer tick, asking Buildbucket for the build status
[00:35:26.201] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:26.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:62:0) after 1m0s
[00:36:26.647] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:62:0)
[00:36:26.647] Timer tick, asking Buildbucket for the build status
[00:36:26.791] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:26.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:63:0) after 1m0s
[00:37:26.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:63:0)
[00:37:26.936] Timer tick, asking Buildbucket for the build status
[00:37:27.045] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:27.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:64:0) after 1m0s
[00:38:27.180] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:64:0)
[00:38:27.180] Timer tick, asking Buildbucket for the build status
[00:38:27.366] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:27.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:65:0) after 1m0s
[00:39:27.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:65:0)
[00:39:27.484] Timer tick, asking Buildbucket for the build status
[00:39:27.597] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:27.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:66:0) after 1m0s
[00:40:27.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:66:0)
[00:40:27.732] Timer tick, asking Buildbucket for the build status
[00:40:27.873] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:27.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:67:0) after 1m0s
[00:41:27.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:67:0)
[00:41:27.994] Timer tick, asking Buildbucket for the build status
[00:41:28.113] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:28.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:68:0) after 1m0s
[00:42:28.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:68:0)
[00:42:28.291] Timer tick, asking Buildbucket for the build status
[00:42:28.440] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:28.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:69:0) after 1m0s
[00:43:28.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:69:0)
[00:43:28.739] Timer tick, asking Buildbucket for the build status
[00:43:29.513] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:29.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:70:0) after 1m0s
[00:44:29.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:70:0)
[00:44:29.604] Timer tick, asking Buildbucket for the build status
[00:44:29.830] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:29.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:71:0) after 1m0s
[00:45:29.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:71:0)
[00:45:29.996] Timer tick, asking Buildbucket for the build status
[00:45:30.166] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:30.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:72:0) after 1m0s
[00:46:30.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:72:0)
[00:46:30.248] Timer tick, asking Buildbucket for the build status
[00:46:30.425] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:30.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:73:0) after 1m0s
[00:47:30.623] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:73:0)
[00:47:30.623] Timer tick, asking Buildbucket for the build status
[00:47:30.755] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:30.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:74:0) after 1m0s
[00:48:30.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:74:0)
[00:48:30.900] Timer tick, asking Buildbucket for the build status
[00:48:32.326] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:32.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:75:0) after 1m0s
[00:49:32.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:75:0)
[00:49:32.436] Timer tick, asking Buildbucket for the build status
[00:49:32.570] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:32.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:76:0) after 1m0s
[00:50:32.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:76:0)
[00:50:32.701] Timer tick, asking Buildbucket for the build status
[00:50:33.219] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:33.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:77:0) after 1m0s
[00:51:33.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:77:0)
[00:51:33.392] Timer tick, asking Buildbucket for the build status
[00:51:34.057] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:34.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:78:0) after 1m0s
[00:52:34.220] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:78:0)
[00:52:34.220] Timer tick, asking Buildbucket for the build status
[00:52:34.419] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:34.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:79:0) after 1m0s
[00:53:34.523] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:79:0)
[00:53:34.523] Timer tick, asking Buildbucket for the build status
[00:53:34.692] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:34.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:80:0) after 1m0s
[00:54:34.717] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:80:0)
[00:54:34.717] Timer tick, asking Buildbucket for the build status
[00:54:34.809] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:34.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:81:0) after 1m0s
[00:55:34.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:81:0)
[00:55:34.898] Timer tick, asking Buildbucket for the build status
[00:55:35.228] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:35.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:82:0) after 1m0s
[00:56:35.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:82:0)
[00:56:35.291] Timer tick, asking Buildbucket for the build status
[00:56:35.832] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:35.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:83:0) after 1m0s
[00:57:35.951] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:83:0)
[00:57:35.951] Timer tick, asking Buildbucket for the build status
[00:57:36.913] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:36.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:84:0) after 1m0s
[00:58:37.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:84:0)
[00:58:37.003] Timer tick, asking Buildbucket for the build status
[00:58:37.116] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:37.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:85:0) after 1m0s
[00:59:37.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:85:0)
[00:59:37.286] Timer tick, asking Buildbucket for the build status
[00:59:37.517] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:37.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:86:0) after 1m0s
[01:00:37.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:86:0)
[01:00:37.599] Timer tick, asking Buildbucket for the build status
[01:00:38.941] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:38.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:87:0) after 1m0s
[01:01:38.944] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:87:0)
[01:01:38.944] Timer tick, asking Buildbucket for the build status
[01:01:41.006] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:41.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:88:0) after 1m0s
[01:02:41.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:88:0)
[01:02:41.069] Timer tick, asking Buildbucket for the build status
[01:02:41.287] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:41.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:89:0) after 1m0s
[01:03:41.372] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:89:0)
[01:03:41.372] Timer tick, asking Buildbucket for the build status
[01:03:43.310] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:43.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:90:0) after 1m0s
[01:04:43.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:90:0)
[01:04:43.537] Timer tick, asking Buildbucket for the build status
[01:04:43.765] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:43.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:91:0) after 1m0s
[01:05:43.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:91:0)
[01:05:43.888] Timer tick, asking Buildbucket for the build status
[01:05:43.964] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:43.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:92:0) after 1m0s
[01:06:44.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:92:0)
[01:06:44.062] Timer tick, asking Buildbucket for the build status
[01:06:44.537] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:44.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:93:0) after 1m0s
[01:07:44.623] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:93:0)
[01:07:44.623] Timer tick, asking Buildbucket for the build status
[01:07:44.764] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:44.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:94:0) after 1m0s
[01:08:44.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:94:0)
[01:08:44.775] Timer tick, asking Buildbucket for the build status
[01:08:44.941] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:44.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:95:0) after 1m0s
[01:09:45.578] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:95:0)
[01:09:45.578] Timer tick, asking Buildbucket for the build status
[01:09:45.684] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:45.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:96:0) after 1m0s
[01:10:46.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:96:0)
[01:10:46.408] Timer tick, asking Buildbucket for the build status
[01:10:46.481] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:46.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:97:0) after 1m0s
[01:11:46.727] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:97:0)
[01:11:46.727] Timer tick, asking Buildbucket for the build status
[01:11:47.561] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:47.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:98:0) after 1m0s
[01:12:47.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:98:0)
[01:12:47.668] Timer tick, asking Buildbucket for the build status
[01:12:47.780] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:47.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:99:0) after 1m0s
[01:13:47.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:99:0)
[01:13:47.844] Timer tick, asking Buildbucket for the build status
[01:13:47.921] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:47.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:100:0) after 1m0s
[01:14:48.017] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:100:0)
[01:14:48.017] Timer tick, asking Buildbucket for the build status
[01:14:48.205] Build 8857090009445740144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:48.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022520071650639392:101:0) after 1m0s
[01:15:38.179] Received PubSub notification, asking Buildbucket for the build status
[01:15:38.717] Build 8857090009445740144: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:15:38.717] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611623735188132",
"created_by": "project:chromium",
"created_ts": "1611617762101997",
"failure_reason": "BUILD_FAILURE",
"id": "8857090009445740144",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5c60c0a35526b5c721e03d49b943c04637d3912d\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- AdsPageLoadMetricsObserverBrowserTest.DisallowedAdFrames_NotMeasured\"}, \"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\": \"5c60c0a35526b5c721e03d49b943c04637d3912d\", \"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-9-snau\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17011, \"clang_revision\": \"llvmorg-12-init-17251-g6de48655-1\", \"got_angle_revision\": \"6689a54d8a046063fad176ffc0fcc1c2cfbe02e8\", \"got_dawn_revision\": \"c00276b2029b85b0cca43ced05173993beaf43e7\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"5c60c0a35526b5c721e03d49b943c04637d3912d\", \"got_revision_cp\": \"refs/heads/master@{#846939}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"413f7cb17c77c95e4cc3ba141f3c0f049ac2ecb2\", \"got_v8_revision\": \"727b659625f9387fe8286da2390bedff96334f13\", \"got_v8_revision_cp\": \"refs/heads/9.0.62@{#1}\", \"got_webrtc_revision\": \"ded6636cf43904448ee926d1f2b4352c8a957ca6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33068}\", \"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\": \"5c60c0a35526b5c721e03d49b943c04637d3912d\", \"swarm_hashes_refs/heads/master(at){#846939}_without_patch\": {\"absl_hardening_tests\": \"95b58bf8cdce404e7e673ab5540c0637b9171bb7\", \"accessibility_unittests\": \"bf61a814065596c7b04b42aa740c04b5e278faeb\", \"angle_unittests\": \"be5fa64d92111a1424e77a7877955d4b815291cc\", \"app_shell_unittests\": \"3595c1760056bd6bc63070c5e1933cc36687f962\", \"aura_unittests\": \"50d723b683c382db23bd0bd018769849456f82bc\", \"base_unittests\": \"7ce6d991084ad4180f99070d42907169ab1b2ddb\", \"base_util_unittests\": \"8a93e4acb71b98f2b4ab503d7fc2047591f73b64\", \"blink_common_unittests\": \"b7f66e2eda53e9bf742ae98dfe8898a08664c5fc\", \"blink_fuzzer_unittests\": \"860f99c5d6182025327302588e8d7acdb25eacea\", \"blink_heap_unittests\": \"69de6ef7d6ba6de18be81cbd18378e7e8607429a\", \"blink_platform_unittests\": \"d2372b520d27e74ce8deaddc8562753d4019f406\", \"blink_unittests\": \"a4c072ff0062323342c17f4a19d567ab752d3521\", \"boringssl_crypto_tests\": \"8b8d4e06dcec0ccb3632bfc89449d90d3f74451f\", \"boringssl_ssl_tests\": \"85bdacf7a56383560f9e1dda0f00847b5bcf83a8\", \"browser_switcher_bho_unittests\": \"cd45ae66b56b56d21e41e81ee3db35118127e337\", \"browser_tests\": \"c97191a68462dafacfe3d11166aa80923a8a4265\", \"capture_unittests\": \"c40731f85915797e1af8d641908b559914edd57c\", \"cast_unittests\": \"58a352e3520f26136d80dbd4d9812aaca6a5feff\", \"cc_unittests\": \"5b45e150a41a99ab5f0586137c2aa37b6fee61e0\", \"chrome_app_unittests\": \"7e71ee350899d77b4704a62de9d8210d0d37b0c7\", \"chrome_cleaner_unittests\": \"cfd644a2d4ded44f68c16783e05646b2838edbf2\", \"chrome_elf_unittests\": \"952e1860fa3d557edca43ac182bee122faedc971\", \"chromedriver_unittests\": \"0f26f43579f2af94d3d8deefbbb1ed41088824be\", \"components_browsertests\": \"883b7eb9488dcec343001ec77e351d6d44584a9a\", \"components_unittests\": \"4825784239ac064206328a4c291594eba198169f\", \"compositor_unittests\": \"bef67b709ea4c285fd6688bc416ff6d96b152351\", \"content_browsertests\": \"da8d8e44abaeee6c783b4d2880bfdf402ed84830\", \"content_unittests\": \"2d99c4353583180a179bd8a357c1f22457541c38\", \"courgette_unittests\": \"25d5f19dc99fb14454e7538febb0e9725771b072\", \"crashpad_tests\": \"1309216c58b9af993b1c0b5aff2fe889b47ccb90\", \"cronet_tests\": \"cd031b02d5b7bfba62653da4367463eca4118d43\", \"cronet_unittests\": \"4459b025d33d956160cbf1618e871e652b532ffe\", \"crypto_unittests\": \"c438d65665032e2805764b28fea8a73b0fdbdf0f\", \"delayloads_unittests\": \"6cf1700f09e71d11b137eb325315de96c2ce26f6\", \"device_unittests\": \"4f0b1303682991cfd5f0cbfe96ea63afe252fa0d\", \"display_unittests\": \"e4aadd33a905e3cdbe8dff7bad2da6db7db39dfd\", \"elevation_service_unittests\": \"fce63062492eaa9d277c2122f08b4071003da154\", \"events_unittests\": \"ee1f0b8193fa28947e077dde4cd9b9d8138355ad\", \"extensions_browsertests\": \"8d2af47fede3ea6e7bdc63f2953426b0adad1a3e\", \"extensions_unittests\": \"7af77ea7ed2df3034de09dac4feb5d84249c0336\", \"filesystem_service_unittests\": \"6bd9298aa79012ee6f1c846a2c1c5861473b5d12\", \"gcm_unit_tests\": \"7b156772a6044643bd1909bde5dee538765ba23c\", \"gcp_unittests\": \"966b3ed6dce654b7b092ffff2c4d63a648bc7e7e\", \"gfx_unittests\": \"7c6f983875cdb739b019fc1f0bf0008f54aee466\", \"gin_unittests\": \"ba58e5c0942c9e01eb1ad06c6a1b8be77168f158\", \"google_apis_unittests\": \"659d4fb6363a12d947758bbe4a038fbfa67a1dc0\", \"gpu_unittests\": \"d57926b7a8a6abb643fce54321aabc124352a50b\", \"gwp_asan_unittests\": \"972ff49dde130ecdf78732a3ce70638d65c2e4e9\", \"headless_browsertests\": \"574dcad98341783cf7c48a524062a6e49c7fb715\", \"headless_unittests\": \"41b9756ceeb22de7cfbec8c2a4ad5903b7124ced\", \"install_static_unittests\": \"9680d20543bb6e0deba96956cdfd7e291af69060\", \"installer_util_unittests\": \"14c6d2bd475e633aa34d3c86f67f386b615920f9\", \"interactive_ui_tests\": \"52024743831960d855978fdbc908b2a6f2939e0d\", \"ipc_tests\": \"232e073a0e9eefd5a50e02b4ead1994e59ed5155\", \"jingle_unittests\": \"29828f413a2ba84d44dbe68014df93228b0efe28\", \"latency_unittests\": \"c17cb07e8bafa9e78deedb1092c1cbc5441989c2\", \"libjingle_xmpp_unittests\": \"bd621d53f98b3a31f33a3f2a517b0581420451bd\", \"liburlpattern_unittests\": \"d7c5a6bc7ef33511ba8396a5dd6c7189ee9e4288\", \"media_blink_unittests\": \"ed56abc4b31c1c391e34651adc96235fb0910151\", \"media_unittests\": \"193a93d2acdb7dd1e12e87ba217a7a865ace99aa\", \"message_center_unittests\": \"3e55b0b96a39fb5cd7628c51e912b87d3f50acf2\", \"midi_unittests\": \"ecbb9be3e165fbeda9e869aa813eea7d0c9a6f9e\", \"mojo_core_unittests\": \"7d3a11bb5703f1969a5360dd47f4179a3aa043cc\", \"mojo_unittests\": \"05d6cd1f7be96bca7e9e85cd6d3adc7ca6eee1c9\", \"nacl_loader_unittests\": \"a20b3179f8a256217e4cd2a4ceef4e68b350e312\", \"native_theme_unittests\": \"76384f7b612a085735bfe4450a52684200ba2c4f\", \"net_unittests\": \"57b85c87bc7f5ebb2ff5c8be73ac22c169385d18\", \"notification_helper_unittests\": \"cf7197897293b1d54402072ad78228f0a832c66c\", \"pdf_unittests\": \"d687802a18c98a10c3c27be1682be5cd62bcc0a6\", \"perfetto_unittests\": \"d1c312f0bd6cda1d0104e6fe3c45a795f03016da\", \"ppapi_unittests\": \"a7766e4b3ba68f2fa0f7951a753f8a6328e6fffe\", \"printing_unittests\": \"5a5905064bd68af57a816227a2c2123924cfe3b5\", \"remoting_unittests\": \"21e2f1f5893098e7a972338f9d32fe049350b1e0\", \"sbox_integration_tests\": \"54f8430392120ab46639be8c2a1952d87c21998b\", \"sbox_unittests\": \"a999084c4021267847acf4f533bcd897e70f5bb1\", \"sbox_validation_tests\": \"e047e2c6c3e2aadb3d35e548993f0e6293f71628\", \"service_manager_unittests\": \"a0ca7315fda5cb792abfeb70b0bbb78492376126\", \"services_unittests\": \"b446c807552aee16d0b1163b8f8fcbdd9b768b48\", \"setup_unittests\": \"05be3ead4bbbb8a01aeac7fbd400fbc2371e79ba\", \"shell_dialogs_unittests\": \"b2c85682893a662b2bddb184bd304478ebf87806\", \"skia_unittests\": \"95e00055a3679ea4f550752896fe64425c583571\", \"snapshot_unittests\": \"4d911fb7723222a8a13bd02e9856bff95a242a5c\", \"sql_unittests\": \"0540816fef3490937a07a175062a16253109d9fe\", \"storage_unittests\": \"ddf715809031172116e58aed4fd200594f88884f\", \"sync_integration_tests\": \"8b3ee088ef166d502da746d37459d8ca9cad5c37\", \"traffic_annotation_auditor_unittests\": \"891ff3bf2cd6575e7fffaac727e69186d3f2b2b8\", \"ui_base_unittests\": \"27759dc4da950ba09c0e5df675905827f6038884\", \"ui_touch_selection_unittests\": \"fb1db09f6241885c10ad7b6f7a04b917f5759859\", \"unit_tests\": \"6c52f9864381a2ddffb9aa17cdef26c3aab8371f\", \"updater_tests\": \"3bd9145f53285fc8716bb1cafe2f359b71d48866\", \"url_unittests\": \"d309bba388b8db7dd6884ba408e21c5bbb881fea\", \"views_unittests\": \"d5e2f374128c07db3224fa88edc0963fff5c52b7\", \"viz_unittests\": \"e05b4212ad0f9ef833faf42c1bb78731f63c2743\", \"vr_common_unittests\": \"814e166215fa1e312b9e0c7139c2a93938cb35d4\", \"vr_pixeltests\": \"f1302e6f933e91920bddd0c42e680e340a5ceb86\", \"weblayer_browsertests\": \"cbee1c5872652dcfdff2dc2951f62b026dbc8fe1\", \"weblayer_unittests\": \"6a232677096ef10324be05092c46bd8db886bddf\", \"wm_unittests\": \"7679b67e16732157faa8d03d43286b70c633a452\", \"wtf_unittests\": \"a5b8ecd790094f43ce69d4d52b65351c58a54f98\", \"zlib_unittests\": \"00af7d59f956e6ae4f04802bcf43cb7c7d77c41d\", \"zucchini_unittests\": \"c5a5694d667e5ac9d12382f429e2ae3384e01c56\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_27a86a15ec8feb386a5b02e9d1f544a49194bc134f7348519b0bd6cd38b20371_v2\", \"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-9-snau\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"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\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- AdsPageLoadMetricsObserverBrowserTest.DisallowedAdFrames_NotMeasured\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611617944858753",
"status": "COMPLETED",
"status_changed_ts": "1611617945928604",
"tags": [
"build_address:luci.chromium.ci/win-asan/17011",
"builder:win-asan",
"buildset:commit/git/5c60c0a35526b5c721e03d49b943c04637d3912d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5c60c0a35526b5c721e03d49b943c04637d3912d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022520071650639392",
"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/8857090009445740144/+/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:5154b90a3cd89510",
"user_agent:luci-scheduler"
],
"updated_ts": "1611623736498405",
"url": "https://ci.chromium.org/b/8857090009445740144",
"utcnow_ts": "1611623738689485"
}
}
[01:15:38.717] Invocation finished in 1h39m38.10259588s with status FAILED