[06:06:07.172] New invocation is queued and will start shortly
[06:06:08.348] Starting the invocation (attempt 1)
[06:06:08.393] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:06:08.393] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:06:08.394] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027931346101860608",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"709868378fd10c18dec52e27c325742ee5ebad1c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027931346101860608",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/709868378fd10c18dec52e27c325742ee5ebad1c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/709868378fd10c18dec52e27c325742ee5ebad1c",
"gitiles_ref:refs/heads/master"
]
}
[06:06:09.253] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606457168489595",
"id": "8862501284052287936",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"709868378fd10c18dec52e27c325742ee5ebad1c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606457169084692",
"tags": [
"build_address:luci.chromium.ci/win-asan/15878",
"builder:win-asan",
"buildset:commit/git/709868378fd10c18dec52e27c325742ee5ebad1c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/709868378fd10c18dec52e27c325742ee5ebad1c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027931346101860608",
"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/8862501284052287936/+/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": "1606457169084824",
"url": "https://ci.chromium.org/b/8862501284052287936",
"utcnow_ts": "1606457169243824"
}
}
[06:06:09.253] Task URL: https://ci.chromium.org/b/8862501284052287936
[06:06:09.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:2:0) after 1m0s
[06:06:12.304] Received PubSub notification, asking Buildbucket for the build status
[06:06:12.388] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:09.256] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:2:0)
[06:07:09.256] Timer tick, asking Buildbucket for the build status
[06:07:09.562] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:09.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:4:0) after 1m0s
[06:08:09.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:4:0)
[06:08:09.645] Timer tick, asking Buildbucket for the build status
[06:08:10.056] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:10.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:5:0) after 1m0s
[06:09:10.084] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:5:0)
[06:09:10.084] Timer tick, asking Buildbucket for the build status
[06:09:10.326] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:10.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:6:0) after 1m0s
[06:10:10.396] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:6:0)
[06:10:10.396] Timer tick, asking Buildbucket for the build status
[06:10:10.531] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:10.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:7:0) after 1m0s
[06:11:10.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:7:0)
[06:11:10.536] Timer tick, asking Buildbucket for the build status
[06:11:10.603] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:10.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:8:0) after 1m0s
[06:12:10.624] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:8:0)
[06:12:10.624] Timer tick, asking Buildbucket for the build status
[06:12:11.009] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:11.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:9:0) after 1m0s
[06:13:11.033] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:9:0)
[06:13:11.033] Timer tick, asking Buildbucket for the build status
[06:13:11.106] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:11.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:10:0) after 1m0s
[06:14:11.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:10:0)
[06:14:11.126] Timer tick, asking Buildbucket for the build status
[06:14:11.347] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:11.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:11:0) after 1m0s
[06:15:11.372] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:11:0)
[06:15:11.372] Timer tick, asking Buildbucket for the build status
[06:15:11.470] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:11.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:12:0) after 1m0s
[06:16:11.491] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:12:0)
[06:16:11.491] Timer tick, asking Buildbucket for the build status
[06:16:11.589] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:11.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:13:0) after 1m0s
[06:17:11.661] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:13:0)
[06:17:11.661] Timer tick, asking Buildbucket for the build status
[06:17:11.745] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:11.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:14:0) after 1m0s
[06:18:11.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:14:0)
[06:18:11.818] Timer tick, asking Buildbucket for the build status
[06:18:11.999] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:11.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:15:0) after 1m0s
[06:19:12.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:15:0)
[06:19:12.010] Timer tick, asking Buildbucket for the build status
[06:19:12.120] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:12.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:16:0) after 1m0s
[06:20:12.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:16:0)
[06:20:12.317] Timer tick, asking Buildbucket for the build status
[06:20:12.539] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:12.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:17:0) after 1m0s
[06:21:12.807] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:17:0)
[06:21:12.807] Timer tick, asking Buildbucket for the build status
[06:21:13.052] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:13.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:18:0) after 1m0s
[06:22:13.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:18:0)
[06:22:13.122] Timer tick, asking Buildbucket for the build status
[06:22:13.517] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:13.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:19:0) after 1m0s
[06:23:13.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:19:0)
[06:23:13.683] Timer tick, asking Buildbucket for the build status
[06:23:14.022] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:14.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:20:0) after 1m0s
[06:24:14.152] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:20:0)
[06:24:14.152] Timer tick, asking Buildbucket for the build status
[06:24:14.560] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:14.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:21:0) after 1m0s
[06:25:14.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:21:0)
[06:25:14.599] Timer tick, asking Buildbucket for the build status
[06:25:14.760] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:14.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:22:0) after 1m0s
[06:26:14.835] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:22:0)
[06:26:14.835] Timer tick, asking Buildbucket for the build status
[06:26:14.983] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:14.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:23:0) after 1m0s
[06:27:15.037] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:23:0)
[06:27:15.037] Timer tick, asking Buildbucket for the build status
[06:27:15.172] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:15.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:24:0) after 1m0s
[06:28:15.289] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:24:0)
[06:28:15.289] Timer tick, asking Buildbucket for the build status
[06:28:15.462] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:15.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:25:0) after 1m0s
[06:29:15.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:25:0)
[06:29:15.536] Timer tick, asking Buildbucket for the build status
[06:29:16.530] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:16.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:26:0) after 1m0s
[06:30:16.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:26:0)
[06:30:16.670] Timer tick, asking Buildbucket for the build status
[06:30:16.763] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:16.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:27:0) after 1m0s
[06:31:16.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:27:0)
[06:31:16.898] Timer tick, asking Buildbucket for the build status
[06:31:17.007] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:17.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:28:0) after 1m0s
[06:32:17.058] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:28:0)
[06:32:17.058] Timer tick, asking Buildbucket for the build status
[06:32:17.128] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:17.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:29:0) after 1m0s
[06:33:17.182] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:29:0)
[06:33:17.182] Timer tick, asking Buildbucket for the build status
[06:33:17.337] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:17.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:30:0) after 1m0s
[06:34:17.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:30:0)
[06:34:17.425] Timer tick, asking Buildbucket for the build status
[06:34:17.543] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:17.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:31:0) after 1m0s
[06:35:18.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:31:0)
[06:35:18.133] Timer tick, asking Buildbucket for the build status
[06:35:18.214] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:18.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:32:0) after 1m0s
[06:36:18.239] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:32:0)
[06:36:18.239] Timer tick, asking Buildbucket for the build status
[06:36:18.512] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:18.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:33:0) after 1m0s
[06:37:18.497] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:33:0)
[06:37:18.497] Timer tick, asking Buildbucket for the build status
[06:37:18.587] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:18.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:34:0) after 1m0s
[06:38:18.724] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:34:0)
[06:38:18.724] Timer tick, asking Buildbucket for the build status
[06:38:19.139] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:19.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:35:0) after 1m0s
[06:39:19.296] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:35:0)
[06:39:19.296] Timer tick, asking Buildbucket for the build status
[06:39:19.366] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:19.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:36:0) after 1m0s
[06:40:19.476] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:36:0)
[06:40:19.476] Timer tick, asking Buildbucket for the build status
[06:40:19.543] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:19.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:37:0) after 1m0s
[06:41:19.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:37:0)
[06:41:19.629] Timer tick, asking Buildbucket for the build status
[06:41:19.763] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:19.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:38:0) after 1m0s
[06:42:19.845] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:38:0)
[06:42:19.845] Timer tick, asking Buildbucket for the build status
[06:42:19.985] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:19.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:39:0) after 1m0s
[06:43:20.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:39:0)
[06:43:20.001] Timer tick, asking Buildbucket for the build status
[06:43:20.140] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:20.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:40:0) after 1m0s
[06:44:20.162] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:40:0)
[06:44:20.162] Timer tick, asking Buildbucket for the build status
[06:44:20.293] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:20.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:41:0) after 1m0s
[06:45:20.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:41:0)
[06:45:20.352] Timer tick, asking Buildbucket for the build status
[06:45:20.555] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:20.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:42:0) after 1m0s
[06:46:20.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:42:0)
[06:46:20.599] Timer tick, asking Buildbucket for the build status
[06:46:20.706] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:20.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:43:0) after 1m0s
[06:47:20.740] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:43:0)
[06:47:20.740] Timer tick, asking Buildbucket for the build status
[06:47:20.827] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:20.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:44:0) after 1m0s
[06:48:20.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:44:0)
[06:48:20.860] Timer tick, asking Buildbucket for the build status
[06:48:21.405] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:21.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:45:0) after 1m0s
[06:49:21.509] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:45:0)
[06:49:21.509] Timer tick, asking Buildbucket for the build status
[06:49:21.783] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:21.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:46:0) after 1m0s
[06:50:21.832] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:46:0)
[06:50:21.832] Timer tick, asking Buildbucket for the build status
[06:50:22.103] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:22.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:47:0) after 1m0s
[06:51:22.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:47:0)
[06:51:22.128] Timer tick, asking Buildbucket for the build status
[06:51:22.233] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:22.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:48:0) after 1m0s
[06:52:22.257] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:48:0)
[06:52:22.257] Timer tick, asking Buildbucket for the build status
[06:52:22.338] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:22.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:49:0) after 1m0s
[06:53:22.387] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:49:0)
[06:53:22.387] Timer tick, asking Buildbucket for the build status
[06:53:22.712] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:22.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:50:0) after 1m0s
[06:54:22.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:50:0)
[06:54:22.739] Timer tick, asking Buildbucket for the build status
[06:54:22.809] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:22.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:51:0) after 1m0s
[06:55:22.906] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:51:0)
[06:55:22.906] Timer tick, asking Buildbucket for the build status
[06:55:22.987] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:22.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:52:0) after 1m0s
[06:56:23.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:52:0)
[06:56:23.043] Timer tick, asking Buildbucket for the build status
[06:56:23.615] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:23.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:53:0) after 1m0s
[06:57:23.640] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:53:0)
[06:57:23.640] Timer tick, asking Buildbucket for the build status
[06:57:23.772] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:23.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:54:0) after 1m0s
[06:58:23.789] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:54:0)
[06:58:23.789] Timer tick, asking Buildbucket for the build status
[06:58:23.924] Build 8862501284052287936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:23.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027931346101860608:55:0) after 1m0s
[06:59:18.878] Received PubSub notification, asking Buildbucket for the build status
[06:59:18.940] Build 8862501284052287936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:59:18.940] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606460357694547",
"created_by": "project:chromium",
"created_ts": "1606457168489595",
"id": "8862501284052287936",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"709868378fd10c18dec52e27c325742ee5ebad1c\"}}",
"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\": \"709868378fd10c18dec52e27c325742ee5ebad1c\", \"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-4-qhsy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15878, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"fcb6b5a5c55ee35d232f35bcfa9c35aefc00f89e\", \"got_dawn_revision\": \"4814bdbdeae40186a61dfb7494390e64820daa4f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"709868378fd10c18dec52e27c325742ee5ebad1c\", \"got_revision_cp\": \"refs/heads/master@{#831482}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"961f93287f84e7e7a7f5ff8a43c7adf14ca7fc42\", \"got_v8_revision_cp\": \"refs/heads/8.9.63@{#1}\", \"got_webrtc_revision\": \"0d863f72a8c747c1b41f2798e5201e1abcdaec2b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32704}\", \"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\": \"709868378fd10c18dec52e27c325742ee5ebad1c\", \"swarm_hashes_refs/heads/master(at){#831482}_without_patch\": {\"absl_hardening_tests\": \"82aa67fbb5885bc90653b5daa2d0c7c71f6c2dba\", \"accessibility_unittests\": \"0fe83d98a7578840fb1437fa65fba284a22eb6c5\", \"angle_unittests\": \"9f0a260d5f9a3f52193277c7df9d258e334435bc\", \"app_shell_unittests\": \"2f0183e183848d55ecf3dcf8c583e1e26a83be8a\", \"aura_unittests\": \"7caaa1dd48ede4bb59e5be397e2ecfeacee9824d\", \"base_unittests\": \"35920118ebf6e42b0262efa1e7d543d83141e12d\", \"base_util_unittests\": \"22dae98eec4f8488849be3196607efa28f5e429e\", \"blink_common_unittests\": \"fbb503fe7c8fd286bdf0d7c0d9f9058ae7118f28\", \"blink_fuzzer_unittests\": \"eaa962640ddfe7963af448c6a1fdc27ff07cf057\", \"blink_heap_unittests\": \"faaf6eec9da6c6f9140989d6eaf984cd11f621ba\", \"blink_platform_unittests\": \"849639488be4a6a516a1af47a3c920250586a70b\", \"blink_unittests\": \"403f0160c7452127f6b88611d5544c780476dc0d\", \"boringssl_crypto_tests\": \"70879457f1fc7b8ba0f90aabe885b4877537f0c8\", \"boringssl_ssl_tests\": \"74d4cfac1c832b14ffe6dd5695a476b5a4421b09\", \"browser_switcher_bho_unittests\": \"af49d9ab209cf4b3b436608eb48c48acd746b828\", \"browser_tests\": \"48f3e42af64ed9d1ddebb73ce2ac96bb370a2102\", \"capture_unittests\": \"839f863c9fa065d6a0210f83a37d455423fd903f\", \"cast_unittests\": \"134e953259f2180fbdca30eebe9e78d0d3000450\", \"cc_unittests\": \"2f147c29b80155c03b21aba22ae0b1a1e6ce609d\", \"chrome_app_unittests\": \"9fbe50090a5ed466bee986fceb83562d0f4b14e9\", \"chrome_cleaner_unittests\": \"37c61fc79cd86e6fe68908e33430f38d813b4c79\", \"chrome_elf_unittests\": \"91e03cbde305f1c5d52ef9877291d75c829323de\", \"chromedriver_unittests\": \"659dd9cc33bd3831b5bf4c4c206e30ca54f100f0\", \"components_browsertests\": \"94d5755b78630179376bb2e3f6e1c8a6b474ff2b\", \"components_unittests\": \"09f8e3637a713ef6519c1fd935bfb3e7cc9ac210\", \"compositor_unittests\": \"750f7e07509a6ad1d14d06f2de388a7a5ca2757a\", \"content_browsertests\": \"58f4283009cefbc6690d5934a852d7872fd08f40\", \"content_unittests\": \"92511eae335c9dce974eb3f886805490efbd33f8\", \"courgette_unittests\": \"73e4c0e4357ffe6f9c0bda3b1aa8053c4a350d1e\", \"crashpad_tests\": \"730d05a025601d65d9be64c43a90dd56b9896ff9\", \"cronet_tests\": \"7fe1b131bec5e6eb993bd8f87a319cc8adab371e\", \"cronet_unittests\": \"9915e97f2921a29ace934f157fe2434c7db78daf\", \"crypto_unittests\": \"1542c0096b5a673dafa8cdbdde8605ab40d8c7b6\", \"delayloads_unittests\": \"51329d3cfa2849311b441f88dd228a3226a4b848\", \"device_unittests\": \"50f5b8bd08a42446d1cce0cb0c20851dd792d0ea\", \"display_unittests\": \"03b755a9d08a9645e37c8f51cb9f54f8185adf88\", \"elevation_service_unittests\": \"59c0eb3fffa34d9812710d903e7224ec038a033b\", \"events_unittests\": \"055b3699b15002a4c486b1ce385cf2f981bc38eb\", \"extensions_browsertests\": \"f374850ae4778a097868a8b9f1986589ac308faf\", \"extensions_unittests\": \"f35a352d7b5a31ce868d74f15b205b601a5301fc\", \"filesystem_service_unittests\": \"2b9d6174380df17284c3b6097638632de7184cfe\", \"gcm_unit_tests\": \"ca34cc921371cf656921e6dbc0eb49cc3c878563\", \"gcp_unittests\": \"ef958cc1e97de1f7328586f4ff83be3a6953cb5c\", \"gfx_unittests\": \"b1efeab18c1322863b135417da3a19e466f4c3a8\", \"gin_unittests\": \"ea193d6d53370394c007fe60f2119969cf1c6f8d\", \"google_apis_unittests\": \"cbbfd09305491ce16b29a95b9b69ef0b5d11554a\", \"gpu_unittests\": \"29377294bb304c9ac573603045f8b3462913a7c0\", \"gwp_asan_unittests\": \"fb9e8672dd9392410d8f62def0ac7de9cbe49b04\", \"headless_browsertests\": \"fe8ed8998d4b8383e6186ce8eea43b4225cc31b0\", \"headless_unittests\": \"a3d410246c051c95426154895769dcad101ada02\", \"install_static_unittests\": \"c5eeb68b34873c43bc8bbf57ddd1b19a4bb4960e\", \"installer_util_unittests\": \"0b7e0243054745f0045b8e3842d550b323440b1e\", \"interactive_ui_tests\": \"fac3c2dd68e861f42dcce28873a57647c692a6c8\", \"ipc_tests\": \"d03d6ab83a72a59c5c25227c60f6ecf71128d17d\", \"jingle_unittests\": \"845135589de88cc03d9eff3211136d307d8ad8f3\", \"latency_unittests\": \"0f2c11751c53ea8815a7f052cb9c2947e14a3437\", \"libjingle_xmpp_unittests\": \"c01e4e51af2611a8081f973e0ba2f1c42a936c71\", \"liburlpattern_unittests\": \"fd05ee5b31addaf5047a0e010bb9f6a5a3b1f3d0\", \"media_blink_unittests\": \"b2c782f5df52c8da82801d1918799242f40f2341\", \"media_unittests\": \"1de483f8b15dca201df50ce60226d36448f407fe\", \"message_center_unittests\": \"bf767430e314f60ab6dae8efb330750eda807d97\", \"midi_unittests\": \"426849819e62b467ba935f7b7b40f4fd5a570f51\", \"mojo_core_unittests\": \"5cd7d119197acac3bc5028d8c948ade749d80ab3\", \"mojo_unittests\": \"0fa223814ec36868dce45966d0e96b428ba15b6b\", \"nacl_loader_unittests\": \"d5e4bace63860e5b890cca8ab8b5ec88ab0f7cae\", \"native_theme_unittests\": \"ae966491a8782ff2dfc6254079d9db8f4c0824f6\", \"net_unittests\": \"5455e1094c834abe756d6aea029b9dd3d56df418\", \"notification_helper_unittests\": \"29c5ccec59a6fe02ebd66497d27b98d3a1b2da85\", \"pdf_unittests\": \"f2c4c83f8d62873e99ab415e48cfad5cafe97f44\", \"perfetto_unittests\": \"f7bed5bba44cdf165d662b7e0342643e9cd3d2f5\", \"ppapi_unittests\": \"56c8dfc18bfa51315e3ebef078cbad7281552cfa\", \"printing_unittests\": \"21b521277bb7471ce55d0174ac46a27f9197a273\", \"remoting_unittests\": \"f4f0d0ff9bcbff2077b2a53f73ff82c82974a7b4\", \"sbox_integration_tests\": \"0823695b4ba828c8c3dcf040649143cd5ee72128\", \"sbox_unittests\": \"d25055c36e66b930aa4d72e0df5e1f84b37a68c9\", \"sbox_validation_tests\": \"a00ad8915b9b94bc6871d3347749ea8accaeb5b0\", \"service_manager_unittests\": \"8225be94d3a561eadd9662204fe90722e6ea6bb6\", \"services_unittests\": \"f448759f583dadd742f995603ba4e8b8eb7f5b9a\", \"setup_unittests\": \"b8c1ef8f517dc25d6ef9b74c318d2cfb997493cd\", \"shell_dialogs_unittests\": \"b748918f79cb4ed29b46b257acd70bf903abfd10\", \"skia_unittests\": \"29f1156f0770ea92fad7a9492b23dca5b58b23bd\", \"snapshot_unittests\": \"611de93daf857181033e48954e6f7427553d5ac1\", \"sql_unittests\": \"190498fc256713750ba125c38236710735059915\", \"storage_unittests\": \"ce7264adb08f0804ec297a272de59b632c2212bb\", \"sync_integration_tests\": \"49f954a76132f1296b9f5841b0843c929df7b0b9\", \"traffic_annotation_auditor_unittests\": \"a751bf21a7ac72ffb81ddb3f72ee3a8378f44cba\", \"ui_base_unittests\": \"491aa35b995bfcd796d857053f4a199878489138\", \"ui_touch_selection_unittests\": \"9a69215e9e0610c8a0dbbd20bc738071512690f0\", \"unit_tests\": \"cf0e0e5229ee679ab781afa3bd30d8d6e7522740\", \"updater_tests\": \"d822459f7c0c16bd68ccaca46ca5127d766939b0\", \"url_unittests\": \"eea1aba62a0a470fe61554f4564fabf9ee541bc3\", \"views_unittests\": \"2430d0813c2d906cf24f5d6992d4fa6a90c6881f\", \"viz_unittests\": \"6cabcfe31ce16edc2d13d527c1b7242656c635d5\", \"vr_common_unittests\": \"ca2728030ccf94b71b31d9497aad8720bf14e0b8\", \"vr_pixeltests\": \"89cc7fbc28813d590ed070169dca2a24c5d52fdc\", \"weblayer_browsertests\": \"0cab4b025431abece1b7b9ce4c0595f262f6c9cf\", \"weblayer_unittests\": \"fd947db2fcf4c63517c12b927b6cabf663c367d3\", \"wm_unittests\": \"28e43fc776942621f80e33bf522860a8654da6b1\", \"wtf_unittests\": \"d989bd3fd18214f01d4a8e58b21403834f23b866\", \"zlib_unittests\": \"827cd81e434ea291b3382deacf14a071d3870896\", \"zucchini_unittests\": \"5fc74bbf6409902855f80c97fb4a1f73fc22a570\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_64c7a62a02e0da5ef76200bb7658267e40edf0984fe7c0f995e5999242969052_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-4-qhsy\"], \"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\": [\"5640-d0eb544\"], \"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": "1606457171225291",
"status": "COMPLETED",
"status_changed_ts": "1606460358133387",
"tags": [
"build_address:luci.chromium.ci/win-asan/15878",
"builder:win-asan",
"buildset:commit/git/709868378fd10c18dec52e27c325742ee5ebad1c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/709868378fd10c18dec52e27c325742ee5ebad1c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027931346101860608",
"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/8862501284052287936/+/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:5021209e57c11a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606460358137860",
"url": "https://ci.chromium.org/b/8862501284052287936",
"utcnow_ts": "1606460358932021"
}
}
[06:59:18.940] Invocation finished in 53m11.789914727s with status SUCCEEDED