[05:16:42.085] New invocation is queued and will start shortly
[05:16:43.162] Starting the invocation (attempt 1)
[05:16:43.200] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:16:43.200] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:16:43.200] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028206246115003888",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"65fbccf71ed7dd6cead30fd206dfe22525a55165\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028206246115003888",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/65fbccf71ed7dd6cead30fd206dfe22525a55165",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/65fbccf71ed7dd6cead30fd206dfe22525a55165",
"gitiles_ref:refs/heads/master"
]
}
[05:16:43.840] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606195003326241",
"id": "8862776184150752688",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"65fbccf71ed7dd6cead30fd206dfe22525a55165\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606195003680789",
"tags": [
"build_address:luci.chromium.ci/win-asan/15815",
"builder:win-asan",
"buildset:commit/git/65fbccf71ed7dd6cead30fd206dfe22525a55165",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/65fbccf71ed7dd6cead30fd206dfe22525a55165",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028206246115003888",
"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/8862776184150752688/+/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": "1606195003680905",
"url": "https://ci.chromium.org/b/8862776184150752688",
"utcnow_ts": "1606195003830204"
}
}
[05:16:43.840] Task URL: https://ci.chromium.org/b/8862776184150752688
[05:16:43.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:2:0) after 1m0s
[05:16:47.887] Received PubSub notification, asking Buildbucket for the build status
[05:16:47.970] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:43.863] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:2:0)
[05:17:43.863] Timer tick, asking Buildbucket for the build status
[05:17:43.963] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:43.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:4:0) after 1m0s
[05:18:43.942] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:4:0)
[05:18:43.942] Timer tick, asking Buildbucket for the build status
[05:18:44.081] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:44.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:5:0) after 1m0s
[05:19:44.192] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:5:0)
[05:19:44.192] Timer tick, asking Buildbucket for the build status
[05:19:44.294] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:44.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:6:0) after 1m0s
[05:20:44.440] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:6:0)
[05:20:44.440] Timer tick, asking Buildbucket for the build status
[05:20:44.562] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:44.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:7:0) after 1m0s
[05:21:44.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:7:0)
[05:21:44.604] Timer tick, asking Buildbucket for the build status
[05:21:45.387] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:45.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:8:0) after 1m0s
[05:22:45.487] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:8:0)
[05:22:45.487] Timer tick, asking Buildbucket for the build status
[05:22:45.594] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:45.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:9:0) after 1m0s
[05:23:45.618] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:9:0)
[05:23:45.618] Timer tick, asking Buildbucket for the build status
[05:23:45.687] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:45.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:10:0) after 1m0s
[05:24:45.799] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:10:0)
[05:24:45.799] Timer tick, asking Buildbucket for the build status
[05:24:45.925] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:45.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:11:0) after 1m0s
[05:25:45.964] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:11:0)
[05:25:45.964] Timer tick, asking Buildbucket for the build status
[05:25:46.035] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:46.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:12:0) after 1m0s
[05:26:46.124] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:12:0)
[05:26:46.124] Timer tick, asking Buildbucket for the build status
[05:26:46.360] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:46.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:13:0) after 1m0s
[05:27:46.497] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:13:0)
[05:27:46.497] Timer tick, asking Buildbucket for the build status
[05:27:46.697] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:46.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:14:0) after 1m0s
[05:28:46.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:14:0)
[05:28:46.755] Timer tick, asking Buildbucket for the build status
[05:28:46.863] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:46.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:15:0) after 1m0s
[05:29:47.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:15:0)
[05:29:47.043] Timer tick, asking Buildbucket for the build status
[05:29:47.152] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:47.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:16:0) after 1m0s
[05:30:47.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:16:0)
[05:30:47.179] Timer tick, asking Buildbucket for the build status
[05:30:48.120] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:48.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:17:0) after 1m0s
[05:31:48.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:17:0)
[05:31:48.179] Timer tick, asking Buildbucket for the build status
[05:31:48.526] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:48.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:18:0) after 1m0s
[05:32:48.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:18:0)
[05:32:48.561] Timer tick, asking Buildbucket for the build status
[05:32:48.703] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:48.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:19:0) after 1m0s
[05:33:48.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:19:0)
[05:33:48.784] Timer tick, asking Buildbucket for the build status
[05:33:49.064] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:49.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:20:0) after 1m0s
[05:34:49.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:20:0)
[05:34:49.155] Timer tick, asking Buildbucket for the build status
[05:34:49.709] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:49.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:21:0) after 1m0s
[05:35:49.704] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:21:0)
[05:35:49.704] Timer tick, asking Buildbucket for the build status
[05:35:49.834] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:49.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:22:0) after 1m0s
[05:36:49.857] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:22:0)
[05:36:49.857] Timer tick, asking Buildbucket for the build status
[05:36:50.123] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:50.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:23:0) after 1m0s
[05:37:50.148] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:23:0)
[05:37:50.148] Timer tick, asking Buildbucket for the build status
[05:37:50.269] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:50.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:24:0) after 1m0s
[05:38:50.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:24:0)
[05:38:50.333] Timer tick, asking Buildbucket for the build status
[05:38:50.453] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:50.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:25:0) after 1m0s
[05:39:50.578] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:25:0)
[05:39:50.578] Timer tick, asking Buildbucket for the build status
[05:39:50.697] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:50.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:26:0) after 1m0s
[05:40:50.787] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:26:0)
[05:40:50.787] Timer tick, asking Buildbucket for the build status
[05:40:51.064] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:51.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:27:0) after 1m0s
[05:41:51.096] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:27:0)
[05:41:51.096] Timer tick, asking Buildbucket for the build status
[05:41:51.612] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:51.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:28:0) after 1m0s
[05:42:51.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:28:0)
[05:42:51.639] Timer tick, asking Buildbucket for the build status
[05:42:51.814] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:51.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:29:0) after 1m0s
[05:43:51.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:29:0)
[05:43:51.813] Timer tick, asking Buildbucket for the build status
[05:43:52.411] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:52.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:30:0) after 1m0s
[05:44:52.480] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:30:0)
[05:44:52.480] Timer tick, asking Buildbucket for the build status
[05:44:52.616] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:52.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:31:0) after 1m0s
[05:45:52.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:31:0)
[05:45:52.639] Timer tick, asking Buildbucket for the build status
[05:45:52.839] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:52.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:32:0) after 1m0s
[05:46:52.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:32:0)
[05:46:52.856] Timer tick, asking Buildbucket for the build status
[05:46:52.979] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:52.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:33:0) after 1m0s
[05:47:53.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:33:0)
[05:47:53.025] Timer tick, asking Buildbucket for the build status
[05:47:53.114] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:53.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:34:0) after 1m0s
[05:48:53.117] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:34:0)
[05:48:53.117] Timer tick, asking Buildbucket for the build status
[05:48:53.271] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:53.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:35:0) after 1m0s
[05:49:53.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:35:0)
[05:49:53.336] Timer tick, asking Buildbucket for the build status
[05:49:53.403] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:53.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:36:0) after 1m0s
[05:50:53.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:36:0)
[05:50:53.431] Timer tick, asking Buildbucket for the build status
[05:50:53.493] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:53.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:37:0) after 1m0s
[05:51:53.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:37:0)
[05:51:53.662] Timer tick, asking Buildbucket for the build status
[05:51:53.785] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:53.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:38:0) after 1m0s
[05:52:53.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:38:0)
[05:52:53.981] Timer tick, asking Buildbucket for the build status
[05:52:54.097] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:54.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:39:0) after 1m0s
[05:53:54.285] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:39:0)
[05:53:54.285] Timer tick, asking Buildbucket for the build status
[05:53:54.629] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:54.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:40:0) after 1m0s
[05:54:54.686] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:40:0)
[05:54:54.686] Timer tick, asking Buildbucket for the build status
[05:54:54.817] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:54.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:41:0) after 1m0s
[05:55:54.799] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:41:0)
[05:55:54.799] Timer tick, asking Buildbucket for the build status
[05:55:54.896] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:54.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:42:0) after 1m0s
[05:56:55.002] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:42:0)
[05:56:55.002] Timer tick, asking Buildbucket for the build status
[05:56:55.145] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:55.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:43:0) after 1m0s
[05:57:55.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:43:0)
[05:57:55.264] Timer tick, asking Buildbucket for the build status
[05:57:55.636] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:55.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:44:0) after 1m0s
[05:58:55.737] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:44:0)
[05:58:55.737] Timer tick, asking Buildbucket for the build status
[05:58:55.854] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:55.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:45:0) after 1m0s
[05:59:55.954] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:45:0)
[05:59:55.954] Timer tick, asking Buildbucket for the build status
[05:59:56.077] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:56.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:46:0) after 1m0s
[06:00:56.231] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:46:0)
[06:00:56.231] Timer tick, asking Buildbucket for the build status
[06:00:56.610] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:56.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:47:0) after 1m0s
[06:01:56.614] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:47:0)
[06:01:56.614] Timer tick, asking Buildbucket for the build status
[06:01:56.758] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:56.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:48:0) after 1m0s
[06:02:56.769] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:48:0)
[06:02:56.769] Timer tick, asking Buildbucket for the build status
[06:02:56.904] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:56.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:49:0) after 1m0s
[06:03:56.929] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:49:0)
[06:03:56.929] Timer tick, asking Buildbucket for the build status
[06:03:57.022] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:57.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:50:0) after 1m0s
[06:04:57.104] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:50:0)
[06:04:57.104] Timer tick, asking Buildbucket for the build status
[06:04:57.186] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:57.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:51:0) after 1m0s
[06:05:57.239] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:51:0)
[06:05:57.239] Timer tick, asking Buildbucket for the build status
[06:05:58.353] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:58.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:52:0) after 1m0s
[06:06:58.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:52:0)
[06:06:58.378] Timer tick, asking Buildbucket for the build status
[06:06:58.505] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:58.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:53:0) after 1m0s
[06:07:58.560] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:53:0)
[06:07:58.560] Timer tick, asking Buildbucket for the build status
[06:07:59.009] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:59.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:54:0) after 1m0s
[06:08:59.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:54:0)
[06:08:59.045] Timer tick, asking Buildbucket for the build status
[06:08:59.152] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:59.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:55:0) after 1m0s
[06:09:59.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:55:0)
[06:09:59.165] Timer tick, asking Buildbucket for the build status
[06:09:59.264] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:59.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:56:0) after 1m0s
[06:10:59.301] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:56:0)
[06:10:59.301] Timer tick, asking Buildbucket for the build status
[06:10:59.473] Build 8862776184150752688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:59.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028206246115003888:57:0) after 1m0s
[06:11:55.055] Received PubSub notification, asking Buildbucket for the build status
[06:11:55.292] Build 8862776184150752688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:11:55.292] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606198314336188",
"created_by": "project:chromium",
"created_ts": "1606195003326241",
"id": "8862776184150752688",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"65fbccf71ed7dd6cead30fd206dfe22525a55165\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"65fbccf71ed7dd6cead30fd206dfe22525a55165\", \"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\": 15815, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"c2a74cbb8ee1b1076c6e28f6aae2e8f8de283f28\", \"got_dawn_revision\": \"03badec5d73ab4138f798b94221546c496177a09\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"65fbccf71ed7dd6cead30fd206dfe22525a55165\", \"got_revision_cp\": \"refs/heads/master@{#830465}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"4ff956a829fefd66af0deeb9bb091fda4389fa21\", \"got_v8_revision_cp\": \"refs/heads/8.9.39@{#1}\", \"got_webrtc_revision\": \"19526a69c763d26f4699f14dd33681db8976a1b1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32676}\", \"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\": \"65fbccf71ed7dd6cead30fd206dfe22525a55165\", \"swarm_hashes_refs/heads/master(at){#830465}_without_patch\": {\"absl_hardening_tests\": \"68220dabff8853b36faac8ed4caba006c78e3f6d\", \"accessibility_unittests\": \"1802b19df4c0fc3d2f33a85c2529fa5c1b3c4df9\", \"angle_unittests\": \"267b488e03d435a60d94a51797ce0c445225caf2\", \"app_shell_unittests\": \"c71add5734ad1a5d387fa2e4d35e6b2fbb0ef2bf\", \"aura_unittests\": \"cb8108b965a040ac8e3dc22abcea5c2ee0f89afc\", \"base_unittests\": \"ac23a4e2db50dc78b25a287ed70aa6991a376421\", \"base_util_unittests\": \"ba1dad7f381d613e0ac4cf90e557cdb748431588\", \"blink_common_unittests\": \"87f0f200db16ae639a822685a0f07af92b4cd29e\", \"blink_fuzzer_unittests\": \"f0a622e6d3499a12870b18251b8d30bd19e1b469\", \"blink_heap_unittests\": \"65386254b239437c15e5a2ec994d4eb1d606a387\", \"blink_platform_unittests\": \"b1447b0eace0088caa8cd9e0f13a2f19d9989c00\", \"blink_unittests\": \"935d3d3723ba7c830c8057111e8cc1480355b472\", \"boringssl_crypto_tests\": \"260a55559a572395d908bf3327ad4027660ba07c\", \"boringssl_ssl_tests\": \"1b2f9e3dd9249eadcbbe720f2364b0be62d49227\", \"browser_switcher_bho_unittests\": \"a56360406e5c7671d66c91f3d7e35b4ea75f2e3b\", \"browser_tests\": \"da52e36cc1cb156e6ca16157e689612623a8c30e\", \"capture_unittests\": \"99551c83bec707aacdeaed59e0c513cf4e6e5911\", \"cast_unittests\": \"283225bc365e4faf575e4c49f5326e02a8ff6344\", \"cc_unittests\": \"ec5c288aa5aa4a1d8d43fe4ec22ec4d4ee85f6af\", \"chrome_app_unittests\": \"38adc687a36209b368aec93aaae7a210934eb54c\", \"chrome_cleaner_unittests\": \"7a4a4a10dbe228cdd5d7138301ffc1842a346f6a\", \"chrome_elf_unittests\": \"f3a49a38a8cb465c85915073a52ab3a80a38df3a\", \"chromedriver_unittests\": \"2e67b86619ad03f44c760bf54396e6dfd64ce8d5\", \"components_browsertests\": \"d3cb5f91bce6dc060211b95ee7e10ee0083b477e\", \"components_unittests\": \"315b31aed97a6af0bafdb024c0306af08571e332\", \"compositor_unittests\": \"61395bdfd80b95b1e8fe91475ba9377502d244af\", \"content_browsertests\": \"cce95d13977b5516a36cb85eb1f6455788fd7b79\", \"content_unittests\": \"373558453ac063d38e48d3af7b6cd81dc7b9841c\", \"courgette_unittests\": \"de2f2040f1736932588335fe678928247f24048d\", \"crashpad_tests\": \"70f7f777f8181898298ca1237adbfeedf7a30046\", \"cronet_tests\": \"cea60dc90862e62e4fc4497a799f39c833969735\", \"cronet_unittests\": \"16f6c701e9652bccf317d3a50136007820123d0a\", \"crypto_unittests\": \"e31d0abc0a3987e007cc85bf152e0036a9400cb5\", \"delayloads_unittests\": \"9ab5debb5a75ff80084e71f8839822bfe131c99d\", \"device_unittests\": \"87d8bebe7e0f6ee70c6b7bd55309cd3d3c9a5d49\", \"display_unittests\": \"cc6462219d3a00d44bdb29ad9160bcf56a07ee4f\", \"elevation_service_unittests\": \"1f589b227bbc22e261e3beb042d585448735853e\", \"events_unittests\": \"750310fba48126c968bc087b16dc7399c6910450\", \"extensions_browsertests\": \"9a097f27f5f828ab82938494bb6a163358f23cb0\", \"extensions_unittests\": \"a9d6efa392358337a724b8e0cb674bce7d3c67f9\", \"filesystem_service_unittests\": \"eb6a70a52f5e7a0f3a675a02262c85c26cd08ee1\", \"gcm_unit_tests\": \"d4a378ed3ea9bfeb8c1355bec75a3de37252be20\", \"gcp_unittests\": \"a0d56a740f59ee722eb80570c13c9fbe525df4b4\", \"gfx_unittests\": \"b88ee8192441d7b4dea00f63af2c258c959df189\", \"gin_unittests\": \"dae39e3831708e9be08be29b8ad70e9639e87b23\", \"google_apis_unittests\": \"4d6e7dc5a6ddfa577810d88282af4fdcece8a831\", \"gpu_unittests\": \"af714fc32c1d2f033941cda80dab9cf61806a79c\", \"gwp_asan_unittests\": \"6a78bce1cbf6b1ce68c1dee3ee39c2953f2d8007\", \"headless_browsertests\": \"724a11d74710a1d8bd27e81279c517fd97a498fa\", \"headless_unittests\": \"ccf58e5dddb2eb6efcf68a38605613b7e859a5d3\", \"install_static_unittests\": \"7e82edd73e5f2f1bd5e9f6422ecbae768b49cc70\", \"installer_util_unittests\": \"9fa4fc1952e2f88e76a805f78c6620908f509566\", \"interactive_ui_tests\": \"c6cb404ef1c1e8d6d203264803ff471e2fea9dee\", \"ipc_tests\": \"492820e137569d48fbadbc68b18ec985f618a313\", \"jingle_unittests\": \"45af441b078658f5262b81c28bfcdf5855a0319a\", \"latency_unittests\": \"ae7535fd27c22a56a1ab22d4c118a925c122d175\", \"libjingle_xmpp_unittests\": \"36b8c8230be03179430798e633367abc8dcd8629\", \"liburlpattern_unittests\": \"a272d434e16c8488d3652c7b741821a129c7771e\", \"media_blink_unittests\": \"4353d584344daa9000980a5f87b535340fafb488\", \"media_unittests\": \"b19ee9125e1d83b0e3b3c53052f362c1c4ea677f\", \"message_center_unittests\": \"2a788e6de25216848800b78a6789633ca554c9db\", \"midi_unittests\": \"78a4081a2c43208a6f746043e6ef63649c06a36f\", \"mojo_core_unittests\": \"0877f4ad1889eaa3ef4455c6db33cdd3eb1c03db\", \"mojo_unittests\": \"3c97ccc6320738eb985a754ddf651adb0f4202ed\", \"nacl_loader_unittests\": \"8cf0da25f1ce69d1b646e1b5966d6f761ef82483\", \"native_theme_unittests\": \"79887488bef24ebee98d782031d97ac5426d7a6d\", \"net_unittests\": \"dcdbe6f307cb446bc755fe20934db358512c3c4b\", \"notification_helper_unittests\": \"fc951d8deb7213a1b3db6a1e0fa2bd8c427059fc\", \"pdf_unittests\": \"50e20456e95797ca796e6582abfba699b26b2f5e\", \"perfetto_unittests\": \"4caf43e0d66feb6eadd61ae5397ecdd3cb71cc9c\", \"ppapi_unittests\": \"d3ecd4bd43c521c98c7180446f61d5482337d11a\", \"printing_unittests\": \"19eed250a8f0a7befababaf0f584896aabdc9d58\", \"remoting_unittests\": \"894c530a95fb3d98de6d8803d9d79b5ab7f3b46e\", \"sbox_integration_tests\": \"b6589497dd13559b24858cc45822699d3e529766\", \"sbox_unittests\": \"12b44e12208fe6006a8a5b936e0fed822d0fd65f\", \"sbox_validation_tests\": \"6e33e0fa59b56a7c6e1724f5ef0309dd8041caac\", \"service_manager_unittests\": \"361426a1b5c8e89b1ceed1fb16174c4a5f4bb53e\", \"services_unittests\": \"63900857b4910e98d95e4438e7697fd105555493\", \"setup_unittests\": \"3fab9bce820bb80c9a957fb87b0d27b0cfa10ab5\", \"shell_dialogs_unittests\": \"51891ab8245e9ab26cbf78249c1669babdc067cd\", \"skia_unittests\": \"aa7786f3284db84c2cce6a20f1a323552a4981e6\", \"snapshot_unittests\": \"3f2c764474f7db16ad69c2f74e1f625b01140e67\", \"sql_unittests\": \"0565fa3ca9c81d97f4a3047cf8ee10c902369f00\", \"storage_unittests\": \"6bf9a1b8d61279e15d474eaca02e138af2a06589\", \"sync_integration_tests\": \"c6508ddb3a766769628a461c2daffd5343c07221\", \"traffic_annotation_auditor_unittests\": \"a6ac45f446971e86e2cbbdc0c7e2fc728d86f2ec\", \"ui_base_unittests\": \"bbf7bdd1384e26c40787669eaa4c99451af60673\", \"ui_touch_selection_unittests\": \"def2946c9da40f0064fe377b399ddbcdbddf8add\", \"unit_tests\": \"5cb920dd2f295bf46841fde9fb95618e9d2a9ecb\", \"updater_tests\": \"cf934db3835a3a48b92b95cd3331ca2312345ad6\", \"url_unittests\": \"152728aac0e08fa0b8d80488d80a95d41a1fde4c\", \"views_unittests\": \"7fea0c4035487a2fa0fa6a77db968789d3241880\", \"viz_unittests\": \"c8290e6c80f674facca5da1b167e5fb5c4714d75\", \"vr_common_unittests\": \"1dac1b18d00cc3771a48687c748c2fd38455a90b\", \"vr_pixeltests\": \"37a8a8835b5de1e0f8826c681dd9fb25091f3432\", \"weblayer_browsertests\": \"b00b97267a4fcf81bfc4d11fd2d1daee4512ad9f\", \"weblayer_unittests\": \"191d934c9428d6320d888aad0f3af55c5e30fa08\", \"wm_unittests\": \"c136a1ee726d48bde9a2f56ca9f956d0f89d8aac\", \"wtf_unittests\": \"79ea024ea9b471e14973acb458cd1bd984533cfd\", \"zlib_unittests\": \"da7b44661fadd43e95ee3bfb8484caa2b48a2224\", \"zucchini_unittests\": \"22acaf2e0ac14cc75d36693ca3691755fac99d91\"}}, \"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\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606195006864074",
"status": "COMPLETED",
"status_changed_ts": "1606198314621927",
"tags": [
"build_address:luci.chromium.ci/win-asan/15815",
"builder:win-asan",
"buildset:commit/git/65fbccf71ed7dd6cead30fd206dfe22525a55165",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/65fbccf71ed7dd6cead30fd206dfe22525a55165",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028206246115003888",
"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/8862776184150752688/+/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:5011804abe655f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606198314643093",
"url": "https://ci.chromium.org/b/8862776184150752688",
"utcnow_ts": "1606198315254642"
}
}
[06:11:55.292] Invocation finished in 55m13.223166741s with status SUCCEEDED