[19:10:51.129] New invocation is queued and will start shortly
[19:10:52.204] Starting the invocation (attempt 1)
[19:10:52.272] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:10:52.272] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:10:52.272] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028516153760340192",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2b24b5cb0a838f946d47bc35c3cc058608fc53ef\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028516153760340192",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/2b24b5cb0a838f946d47bc35c3cc058608fc53ef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2b24b5cb0a838f946d47bc35c3cc058608fc53ef",
"gitiles_ref:refs/heads/master"
]
}
[19:10:53.093] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605899452427443",
"id": "8863086091730092112",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2b24b5cb0a838f946d47bc35c3cc058608fc53ef\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605899452950923",
"tags": [
"build_address:luci.chromium.ci/win-asan/15745",
"builder:win-asan",
"buildset:commit/git/2b24b5cb0a838f946d47bc35c3cc058608fc53ef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2b24b5cb0a838f946d47bc35c3cc058608fc53ef",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028516153760340192",
"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/8863086091730092112/+/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": "1605899452951058",
"url": "https://ci.chromium.org/b/8863086091730092112",
"utcnow_ts": "1605899453072564"
}
}
[19:10:53.093] Task URL: https://ci.chromium.org/b/8863086091730092112
[19:10:53.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:2:0) after 1m0s
[19:11:08.087] Received PubSub notification, asking Buildbucket for the build status
[19:11:08.179] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:53.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:2:0)
[19:11:53.146] Timer tick, asking Buildbucket for the build status
[19:11:53.260] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:53.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:4:0) after 1m0s
[19:12:53.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:4:0)
[19:12:53.375] Timer tick, asking Buildbucket for the build status
[19:12:55.512] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:55.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:5:0) after 1m0s
[19:13:55.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:5:0)
[19:13:55.567] Timer tick, asking Buildbucket for the build status
[19:13:55.747] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:55.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:6:0) after 1m0s
[19:14:55.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:6:0)
[19:14:55.873] Timer tick, asking Buildbucket for the build status
[19:14:55.967] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:55.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:7:0) after 1m0s
[19:15:56.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:7:0)
[19:15:56.032] Timer tick, asking Buildbucket for the build status
[19:15:56.147] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:56.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:8:0) after 1m0s
[19:16:56.180] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:8:0)
[19:16:56.180] Timer tick, asking Buildbucket for the build status
[19:16:56.645] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:56.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:9:0) after 1m0s
[19:17:56.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:9:0)
[19:17:56.725] Timer tick, asking Buildbucket for the build status
[19:17:56.802] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:56.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:10:0) after 1m0s
[19:18:56.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:10:0)
[19:18:56.862] Timer tick, asking Buildbucket for the build status
[19:18:57.184] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:57.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:11:0) after 1m0s
[19:19:57.236] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:11:0)
[19:19:57.236] Timer tick, asking Buildbucket for the build status
[19:19:57.317] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:57.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:12:0) after 1m0s
[19:20:57.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:12:0)
[19:20:57.305] Timer tick, asking Buildbucket for the build status
[19:20:57.375] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:57.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:13:0) after 1m0s
[19:21:57.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:13:0)
[19:21:57.403] Timer tick, asking Buildbucket for the build status
[19:21:57.516] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:57.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:14:0) after 1m0s
[19:22:57.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:14:0)
[19:22:57.552] Timer tick, asking Buildbucket for the build status
[19:22:57.750] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:57.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:15:0) after 1m0s
[19:23:57.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:15:0)
[19:23:57.756] Timer tick, asking Buildbucket for the build status
[19:23:59.812] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:59.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:16:0) after 1m0s
[19:24:59.861] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:16:0)
[19:24:59.861] Timer tick, asking Buildbucket for the build status
[19:25:00.204] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:00.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:17:0) after 1m0s
[19:26:00.187] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:17:0)
[19:26:00.187] Timer tick, asking Buildbucket for the build status
[19:26:00.320] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:00.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:18:0) after 1m0s
[19:27:00.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:18:0)
[19:27:00.715] Timer tick, asking Buildbucket for the build status
[19:27:00.853] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:00.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:19:0) after 1m0s
[19:28:01.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:19:0)
[19:28:01.087] Timer tick, asking Buildbucket for the build status
[19:28:01.573] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:01.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:20:0) after 1m0s
[19:29:01.882] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:20:0)
[19:29:01.882] Timer tick, asking Buildbucket for the build status
[19:29:02.072] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:02.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:21:0) after 1m0s
[19:30:02.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:21:0)
[19:30:02.636] Timer tick, asking Buildbucket for the build status
[19:30:03.002] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:03.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:22:0) after 1m0s
[19:31:03.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:22:0)
[19:31:03.082] Timer tick, asking Buildbucket for the build status
[19:31:03.252] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:03.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:23:0) after 1m0s
[19:32:03.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:23:0)
[19:32:03.246] Timer tick, asking Buildbucket for the build status
[19:32:03.697] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:03.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:24:0) after 1m0s
[19:33:03.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:24:0)
[19:33:03.694] Timer tick, asking Buildbucket for the build status
[19:33:03.810] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:03.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:25:0) after 1m0s
[19:34:03.827] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:25:0)
[19:34:03.827] Timer tick, asking Buildbucket for the build status
[19:34:04.039] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:04.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:26:0) after 1m0s
[19:35:04.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:26:0)
[19:35:04.173] Timer tick, asking Buildbucket for the build status
[19:35:04.515] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:04.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:27:0) after 1m0s
[19:36:04.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:27:0)
[19:36:04.725] Timer tick, asking Buildbucket for the build status
[19:36:05.042] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:05.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:28:0) after 1m0s
[19:37:05.054] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:28:0)
[19:37:05.054] Timer tick, asking Buildbucket for the build status
[19:37:05.214] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:05.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:29:0) after 1m0s
[19:38:05.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:29:0)
[19:38:05.321] Timer tick, asking Buildbucket for the build status
[19:38:05.467] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:05.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:30:0) after 1m0s
[19:39:05.542] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:30:0)
[19:39:05.542] Timer tick, asking Buildbucket for the build status
[19:39:05.651] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:05.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:31:0) after 1m0s
[19:40:05.737] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:31:0)
[19:40:05.737] Timer tick, asking Buildbucket for the build status
[19:40:06.924] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:06.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:32:0) after 1m0s
[19:41:06.964] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:32:0)
[19:41:06.964] Timer tick, asking Buildbucket for the build status
[19:41:07.152] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:07.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:33:0) after 1m0s
[19:42:07.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:33:0)
[19:42:07.248] Timer tick, asking Buildbucket for the build status
[19:42:07.337] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:07.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:34:0) after 1m0s
[19:43:07.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:34:0)
[19:43:07.325] Timer tick, asking Buildbucket for the build status
[19:43:08.143] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:08.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:35:0) after 1m0s
[19:44:08.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:35:0)
[19:44:08.215] Timer tick, asking Buildbucket for the build status
[19:44:08.809] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:08.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:36:0) after 1m0s
[19:45:08.817] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:36:0)
[19:45:08.817] Timer tick, asking Buildbucket for the build status
[19:45:08.899] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:08.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:37:0) after 1m0s
[19:46:09.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:37:0)
[19:46:09.055] Timer tick, asking Buildbucket for the build status
[19:46:09.502] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:09.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:38:0) after 1m0s
[19:47:09.541] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:38:0)
[19:47:09.541] Timer tick, asking Buildbucket for the build status
[19:47:09.740] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:09.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:39:0) after 1m0s
[19:48:09.903] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:39:0)
[19:48:09.903] Timer tick, asking Buildbucket for the build status
[19:48:09.991] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:09.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:40:0) after 1m0s
[19:49:10.081] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:40:0)
[19:49:10.081] Timer tick, asking Buildbucket for the build status
[19:49:10.164] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:10.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:41:0) after 1m0s
[19:50:10.231] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:41:0)
[19:50:10.231] Timer tick, asking Buildbucket for the build status
[19:50:10.346] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:10.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:42:0) after 1m0s
[19:51:10.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:42:0)
[19:51:10.371] Timer tick, asking Buildbucket for the build status
[19:51:10.494] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:10.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:43:0) after 1m0s
[19:52:10.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:43:0)
[19:52:10.545] Timer tick, asking Buildbucket for the build status
[19:52:11.046] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:11.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:44:0) after 1m0s
[19:53:11.103] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:44:0)
[19:53:11.104] Timer tick, asking Buildbucket for the build status
[19:53:11.337] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:11.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:45:0) after 1m0s
[19:54:11.410] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:45:0)
[19:54:11.410] Timer tick, asking Buildbucket for the build status
[19:54:12.025] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:12.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:46:0) after 1m0s
[19:55:12.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:46:0)
[19:55:12.057] Timer tick, asking Buildbucket for the build status
[19:55:12.910] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:12.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:47:0) after 1m0s
[19:56:12.954] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:47:0)
[19:56:12.954] Timer tick, asking Buildbucket for the build status
[19:56:13.249] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:13.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:48:0) after 1m0s
[19:57:13.404] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:48:0)
[19:57:13.404] Timer tick, asking Buildbucket for the build status
[19:57:14.032] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:14.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:49:0) after 1m0s
[19:58:14.161] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:49:0)
[19:58:14.161] Timer tick, asking Buildbucket for the build status
[19:58:14.236] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:14.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:50:0) after 1m0s
[19:59:14.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:50:0)
[19:59:14.325] Timer tick, asking Buildbucket for the build status
[19:59:14.413] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:14.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:51:0) after 1m0s
[20:00:14.571] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:51:0)
[20:00:14.571] Timer tick, asking Buildbucket for the build status
[20:00:14.719] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:14.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:52:0) after 1m0s
[20:01:14.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:52:0)
[20:01:14.825] Timer tick, asking Buildbucket for the build status
[20:01:15.012] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:15.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:53:0) after 1m0s
[20:02:15.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:53:0)
[20:02:15.082] Timer tick, asking Buildbucket for the build status
[20:02:15.170] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:15.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:54:0) after 1m0s
[20:03:15.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:54:0)
[20:03:15.224] Timer tick, asking Buildbucket for the build status
[20:03:15.369] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:15.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:55:0) after 1m0s
[20:04:15.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:55:0)
[20:04:15.455] Timer tick, asking Buildbucket for the build status
[20:04:15.586] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:15.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:56:0) after 1m0s
[20:05:15.647] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:56:0)
[20:05:15.647] Timer tick, asking Buildbucket for the build status
[20:05:16.608] Build 8863086091730092112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:16.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028516153760340192:57:0) after 1m0s
[20:06:01.783] Received PubSub notification, asking Buildbucket for the build status
[20:06:01.886] Build 8863086091730092112: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:06:01.886] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605902759649084",
"created_by": "project:chromium",
"created_ts": "1605899452427443",
"failure_reason": "BUILD_FAILURE",
"id": "8863086091730092112",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2b24b5cb0a838f946d47bc35c3cc058608fc53ef\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**services_unittests** failed.\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"2b24b5cb0a838f946d47bc35c3cc058608fc53ef\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-3-xoby\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15745, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"7784fce44d7b02b849b1e72a830296356f2d5791\", \"got_dawn_revision\": \"d2953cff41e76f2a48bb43c0a62b9ce1936496a5\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"2b24b5cb0a838f946d47bc35c3cc058608fc53ef\", \"got_revision_cp\": \"refs/heads/master@{#829734}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"de9e649438ed3cc2ecf5c30ebf08f033d01270e6\", \"got_v8_revision\": \"94b2c943f7f37e0450e7c5d029fbd22a9d7f6946\", \"got_v8_revision_cp\": \"refs/heads/8.9.14@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"2b24b5cb0a838f946d47bc35c3cc058608fc53ef\", \"swarm_hashes_refs/heads/master(at){#829734}_without_patch\": {\"absl_hardening_tests\": \"85c7e5355564b431e9932f82eafaa279d9447ee5\", \"accessibility_unittests\": \"c6fe652950a7b5c774adf6975576e3f870aa3ffc\", \"angle_unittests\": \"af71cf867148f5df16f79b333acbac36b02ea3b9\", \"app_shell_unittests\": \"af7ca27469ee6a4c5742937cd1162c0746d6ee60\", \"aura_unittests\": \"d57964ebb6fe67d8ceed3ea88491c860201b203a\", \"base_unittests\": \"a1ada44163df7f53a9ee1bab19eaa6caa40b8a08\", \"base_util_unittests\": \"1a002dd3f8606b8783ac09821799b3fe8ce6878d\", \"blink_common_unittests\": \"df3e9eba31187e38098498e99c8d14361729663e\", \"blink_fuzzer_unittests\": \"a4afb8e56bc3c5dc25fce10ae89af2d094f327dc\", \"blink_heap_unittests\": \"10114110fe7d41490f14921e2b5747d61f97f03a\", \"blink_platform_unittests\": \"87f3bcd798939c21547a7a491ff08e55644240c5\", \"blink_unittests\": \"71d6e42879e5fed26435ea3a218a279912dfe2bd\", \"boringssl_crypto_tests\": \"f4bebb9e9c5747b3b28f65867a0cc92a000f131b\", \"boringssl_ssl_tests\": \"ba59275bd693335bfb24591d74b81ae0448794bc\", \"browser_switcher_bho_unittests\": \"0bac1a0d81c65c9a42b92d991d65fb6f46326a51\", \"browser_tests\": \"02e9fa45d6e130455bdd5364a883a224638ad6c3\", \"capture_unittests\": \"3b8ff6e758fbff077f58c72bd6db6381b1955084\", \"cast_unittests\": \"66705e34ba2f0cbc7aabf6d8544416c1821c4b34\", \"cc_unittests\": \"d51927c34faa775bb294280b521b2fad03c0e24f\", \"chrome_app_unittests\": \"67d6e4955fa4ffcd50eae7b2ba56b71db4abcd41\", \"chrome_cleaner_unittests\": \"3a69b6cf27c76ef8f99ebd9a23abab5f3b564ae6\", \"chrome_elf_unittests\": \"812de7f276e4e9ca92823c777d160c2ad92fc953\", \"chromedriver_unittests\": \"6384f5ee68febcb4a6ee3768fa700bc53063a25a\", \"components_browsertests\": \"ae42dbfc02fe8ee810bfb6f06162cbd397eb7e5b\", \"components_unittests\": \"db7cb8cef1917d127cb9fef6396af2a7762c6d39\", \"compositor_unittests\": \"e380c8ff1a0d01b86f0ee0aa629c97ad91fc6c16\", \"content_browsertests\": \"4a93460d19ca9dce9f12515098201a7e75ff81b9\", \"content_unittests\": \"6ff85c0b9b4d1fff0301286cb722f50070279fb6\", \"courgette_unittests\": \"161150e15988cde09ee071f3ece5f02a04f493d1\", \"crashpad_tests\": \"0b151cb2b7f860fd005d2800478cf46c0190d8cd\", \"cronet_tests\": \"733a3b688274316c2f12f4023d651767f265a883\", \"cronet_unittests\": \"fc75b4d5312bc405d18751409515f1b1802faeba\", \"crypto_unittests\": \"c1c7cfcc4d21524f42ee950d5cc22ae6dc6cb169\", \"delayloads_unittests\": \"60d2739fcc3856203e6c7a28cfdf5800ee7e112b\", \"device_unittests\": \"a1947a29f8b445ad5a9f8b7f16e31583cce4aac5\", \"display_unittests\": \"bebafffd0f4e520736818459c035f2ee61ff7d17\", \"elevation_service_unittests\": \"01e82c7bce479587eb4d27c28e07fe1ae8aad6db\", \"events_unittests\": \"31888b265624e285c842cfaa3bc7c36ca9d80ff6\", \"extensions_browsertests\": \"103a50cfcc907ccd4ad7ddc2cf44097fd06f7d96\", \"extensions_unittests\": \"aa7052a37b7ff6160b28a526e17b8b1544920225\", \"filesystem_service_unittests\": \"55e1f4eef88ef3a1fdb21efc1ab88bf5df3e065d\", \"gcm_unit_tests\": \"def876d43d729e26e192bfd821209b16cdf2879b\", \"gcp_unittests\": \"dc092ad3dd4029c8c1f34aafaafd7c8dd06d53e4\", \"gfx_unittests\": \"6771e437555cfdad8cd6af5dd16c2ea4c40ea3d8\", \"gin_unittests\": \"bd4e714b4dd41235f393a0f00cf46709b0b2aa13\", \"google_apis_unittests\": \"b32871ed00b3e9f8e308a98c24bf8a92053013cf\", \"gpu_unittests\": \"699be78b002298b88e187336803f4fba5f9f7054\", \"gwp_asan_unittests\": \"52f205f013d478adbf5c1027353161dcd50d385c\", \"headless_browsertests\": \"ffa3b2427a5f8eecf3ffbcea911e72e75d6a4543\", \"headless_unittests\": \"fb0de5db69803a61b919963055c042d76b534e64\", \"install_static_unittests\": \"a984cd89bdde834f86f7ed27593fd5aa657ed0e6\", \"installer_util_unittests\": \"796941467cef09cba6b7df44bfc4a81c8bc05339\", \"interactive_ui_tests\": \"f7eee0cf22e779a26d6a1830c68edbddcf88dc34\", \"ipc_tests\": \"d5c85b795e83aa990e080f1d01fd5ec2f5c17215\", \"jingle_unittests\": \"9a3da50fe32b89901eff9ebeccdcc2edeb8b0916\", \"latency_unittests\": \"9c66daeba81d4d4b628550f402115899797e078e\", \"libjingle_xmpp_unittests\": \"6efd99ade672426a5777029ba93582d99c498e1f\", \"liburlpattern_unittests\": \"252880fa14d97b04078692a10b9eaed62af65cfe\", \"media_blink_unittests\": \"6c56807e2cf2453df9a4dcb2b27c8651fc0f2456\", \"media_unittests\": \"e1e1f6b0afb5593825b22b5155e6890c5a9e5ba1\", \"message_center_unittests\": \"c96174863f6e5d91f31d8143c198159c2a9b0370\", \"midi_unittests\": \"356bd7dae1448605ffc785d982df4002ef62cfe8\", \"mojo_core_unittests\": \"55020a41d84bec484e707a3a73ff4dc4fca1e047\", \"mojo_unittests\": \"75d11ecf85a97f9c2591eb0b4089e34d68974be9\", \"nacl_loader_unittests\": \"83ff81bd4c552b91deee60b6f26eb65badbd8510\", \"native_theme_unittests\": \"e4b812dbdc656d736941511b82063001a0ba87ee\", \"net_unittests\": \"e46b5358653b6ac79053459d4662ec7bad10d39d\", \"notification_helper_unittests\": \"50c3523c831649506d3e052e2d0904be33852ac1\", \"pdf_unittests\": \"9c7241363faa06556f87e56bd8cc2a28c7e9c628\", \"perfetto_unittests\": \"7266fdfd769eb436be53e7c0c0bf11722c4bc82c\", \"ppapi_unittests\": \"4bb805e769b4372dbad8fb8d84c5f1e18098ca5d\", \"printing_unittests\": \"d2d12dc8539897994ad092eec703eb79a154c9cb\", \"remoting_unittests\": \"4ba493ae89c480e6299d3d03c6484a76ff856537\", \"sbox_integration_tests\": \"7adf15eed16674b33d18b38952a777a484455bdc\", \"sbox_unittests\": \"cfe1281c7925f81576b59f8657e3b109e5526d1d\", \"sbox_validation_tests\": \"b257fb3aa9faca8e5d4a7ad088e7f90c14cff0c1\", \"service_manager_unittests\": \"d1863743fd5cb4767064d185e97d7a879a8c0f8a\", \"services_unittests\": \"03daf7a281e5e834c45837642f253af0c01d7535\", \"setup_unittests\": \"3be4527ffaedccc9ccb9cf43a407cf22e00bb9d2\", \"shell_dialogs_unittests\": \"dc7f84288e089203e3334323544dad7208249e90\", \"skia_unittests\": \"063788e073adef55dcaad0b6b6b47406122e3485\", \"snapshot_unittests\": \"cb165b9075948b6b31ae8370d4a7730d82447aa5\", \"sql_unittests\": \"73fd41682403e5d8d0ac4c45db408020f34bf5c1\", \"storage_unittests\": \"752ecd2b927e129f5c079f15543801fd48714347\", \"sync_integration_tests\": \"3f5d7a82511e6773cea7fda15964ae7c0711f812\", \"traffic_annotation_auditor_unittests\": \"6943c3b23d71abc8de2ac1f5c50bf373b1336296\", \"ui_base_unittests\": \"27ad0a2b3c16e4e441d0230a58880593f6069abc\", \"ui_touch_selection_unittests\": \"f3401c1b0a1ce86e2ede1404902a850e1a54d728\", \"unit_tests\": \"d5ac799878b3d352ee26c112386c7a24cdc1657f\", \"updater_tests\": \"40f245479ebb95514dea67cd2b753ea1924e435f\", \"url_unittests\": \"dec7a79dad8327a4ede12dfeab319a84590294d9\", \"views_unittests\": \"657e96c7e57a06c107c8114d337c5e89ecd0895c\", \"viz_unittests\": \"01ddfb1b23e5f6225fb671b5b09ef7657231cc2f\", \"vr_common_unittests\": \"377f9ec33359462cbed7fb80787b18ae98a41fdd\", \"vr_pixeltests\": \"e5df8b738b8eddd3089e819ed28f198f884d7f5a\", \"weblayer_browsertests\": \"d3d8c98cde3e48e309e41d0693352d2ec11bbd78\", \"weblayer_unittests\": \"73c4a293dd3d4c6d900a2a00c4a52b2d23375039\", \"wm_unittests\": \"497f391faa57eb90a596a4d01a85fecf1bd8d19a\", \"wtf_unittests\": \"6d013d546c2bb15c15e969f88c54d1636977d839\", \"zlib_unittests\": \"ae9e3a30bd5c7ba65d4c543aa824e138d11a4b8c\", \"zucchini_unittests\": \"ede0635674bbe26dcfd2e64e1a2891716ab190dd\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-3-xoby\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**services_unittests** failed.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605899466938535",
"status": "COMPLETED",
"status_changed_ts": "1605899467454636",
"tags": [
"build_address:luci.chromium.ci/win-asan/15745",
"builder:win-asan",
"buildset:commit/git/2b24b5cb0a838f946d47bc35c3cc058608fc53ef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2b24b5cb0a838f946d47bc35c3cc058608fc53ef",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028516153760340192",
"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/8863086091730092112/+/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:4fffe298f33b7210",
"user_agent:luci-scheduler"
],
"updated_ts": "1605902761108909",
"url": "https://ci.chromium.org/b/8863086091730092112",
"utcnow_ts": "1605902761876507"
}
}
[20:06:01.886] Invocation finished in 55m10.779208839s with status FAILED