[09:50:08.959] New invocation is queued and will start shortly
[09:50:10.131] Starting the invocation (attempt 1)
[09:50:10.167] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:50:10.167] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:50:10.167] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019310539553038800",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8749215a7b33eceb7f0fcc5b7081a6944799d754\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9019310539553038800",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/8749215a7b33eceb7f0fcc5b7081a6944799d754",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8749215a7b33eceb7f0fcc5b7081a6944799d754",
"gitiles_ref:refs/heads/master"
]
}
[09:50:10.726] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614678610235015",
"id": "8853880477552265008",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8749215a7b33eceb7f0fcc5b7081a6944799d754\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614678610604626",
"tags": [
"build_address:luci.chromium.ci/win-asan/17589",
"builder:win-asan",
"buildset:commit/git/8749215a7b33eceb7f0fcc5b7081a6944799d754",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8749215a7b33eceb7f0fcc5b7081a6944799d754",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019310539553038800",
"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/8853880477552265008/+/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": "1614678610604760",
"url": "https://ci.chromium.org/b/8853880477552265008",
"utcnow_ts": "1614678610718996"
}
}
[09:50:10.726] Task URL: https://ci.chromium.org/b/8853880477552265008
[09:50:10.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:2:0) after 1m0s
[09:50:13.732] Received PubSub notification, asking Buildbucket for the build status
[09:50:13.820] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:10.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:2:0)
[09:51:10.755] Timer tick, asking Buildbucket for the build status
[09:51:10.927] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:10.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:4:0) after 1m0s
[09:52:10.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:4:0)
[09:52:10.963] Timer tick, asking Buildbucket for the build status
[09:52:11.039] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:11.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:5:0) after 1m0s
[09:53:11.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:5:0)
[09:53:11.711] Timer tick, asking Buildbucket for the build status
[09:53:11.770] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:11.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:6:0) after 1m0s
[09:54:11.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:6:0)
[09:54:11.885] Timer tick, asking Buildbucket for the build status
[09:54:11.945] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:11.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:7:0) after 1m0s
[09:55:12.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:7:0)
[09:55:12.133] Timer tick, asking Buildbucket for the build status
[09:55:12.192] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:12.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:8:0) after 1m0s
[09:56:12.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:8:0)
[09:56:12.292] Timer tick, asking Buildbucket for the build status
[09:56:12.371] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:12.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:9:0) after 1m0s
[09:57:12.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:9:0)
[09:57:12.899] Timer tick, asking Buildbucket for the build status
[09:57:12.983] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:12.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:10:0) after 1m0s
[09:58:13.011] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:10:0)
[09:58:13.011] Timer tick, asking Buildbucket for the build status
[09:58:13.075] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:13.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:11:0) after 1m0s
[09:59:13.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:11:0)
[09:59:13.158] Timer tick, asking Buildbucket for the build status
[09:59:13.412] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:13.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:12:0) after 1m0s
[10:00:13.522] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:12:0)
[10:00:13.522] Timer tick, asking Buildbucket for the build status
[10:00:13.740] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:13.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:13:0) after 1m0s
[10:01:13.781] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:13:0)
[10:01:13.781] Timer tick, asking Buildbucket for the build status
[10:01:14.014] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:14.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:14:0) after 1m0s
[10:02:13.986] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:14:0)
[10:02:13.986] Timer tick, asking Buildbucket for the build status
[10:02:14.135] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:14.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:15:0) after 1m0s
[10:03:14.245] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:15:0)
[10:03:14.245] Timer tick, asking Buildbucket for the build status
[10:03:14.331] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:14.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:16:0) after 1m0s
[10:04:14.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:16:0)
[10:04:14.347] Timer tick, asking Buildbucket for the build status
[10:04:14.411] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:14.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:17:0) after 1m0s
[10:05:14.437] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:17:0)
[10:05:14.437] Timer tick, asking Buildbucket for the build status
[10:05:15.125] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:15.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:18:0) after 1m0s
[10:06:15.132] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:18:0)
[10:06:15.132] Timer tick, asking Buildbucket for the build status
[10:06:15.202] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:15.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:19:0) after 1m0s
[10:07:15.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:19:0)
[10:07:15.214] Timer tick, asking Buildbucket for the build status
[10:07:15.361] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:15.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:20:0) after 1m0s
[10:08:15.386] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:20:0)
[10:08:15.386] Timer tick, asking Buildbucket for the build status
[10:08:15.484] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:15.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:21:0) after 1m0s
[10:09:15.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:21:0)
[10:09:15.451] Timer tick, asking Buildbucket for the build status
[10:09:15.546] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:15.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:22:0) after 1m0s
[10:10:15.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:22:0)
[10:10:15.572] Timer tick, asking Buildbucket for the build status
[10:10:15.662] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:15.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:23:0) after 1m0s
[10:11:15.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:23:0)
[10:11:15.711] Timer tick, asking Buildbucket for the build status
[10:11:15.774] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:15.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:24:0) after 1m0s
[10:12:15.793] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:24:0)
[10:12:15.793] Timer tick, asking Buildbucket for the build status
[10:12:16.011] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:16.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:25:0) after 1m0s
[10:13:16.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:25:0)
[10:13:16.008] Timer tick, asking Buildbucket for the build status
[10:13:16.089] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:16.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:26:0) after 1m0s
[10:14:16.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:26:0)
[10:14:16.116] Timer tick, asking Buildbucket for the build status
[10:14:16.192] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:16.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:27:0) after 1m0s
[10:15:16.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:27:0)
[10:15:16.216] Timer tick, asking Buildbucket for the build status
[10:15:16.315] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:16.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:28:0) after 1m0s
[10:16:16.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:28:0)
[10:16:16.537] Timer tick, asking Buildbucket for the build status
[10:16:16.653] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:16.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:29:0) after 1m0s
[10:17:16.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:29:0)
[10:17:16.876] Timer tick, asking Buildbucket for the build status
[10:17:16.959] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:16.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:30:0) after 1m0s
[10:18:17.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:30:0)
[10:18:17.361] Timer tick, asking Buildbucket for the build status
[10:18:17.449] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:17.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:31:0) after 1m0s
[10:19:17.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:31:0)
[10:19:17.762] Timer tick, asking Buildbucket for the build status
[10:19:17.837] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:17.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:32:0) after 1m0s
[10:20:18.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:32:0)
[10:20:18.053] Timer tick, asking Buildbucket for the build status
[10:20:18.162] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:18.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:33:0) after 1m0s
[10:21:18.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:33:0)
[10:21:18.544] Timer tick, asking Buildbucket for the build status
[10:21:18.852] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:18.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:34:0) after 1m0s
[10:22:18.929] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:34:0)
[10:22:18.929] Timer tick, asking Buildbucket for the build status
[10:22:19.244] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:19.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:35:0) after 1m0s
[10:23:19.446] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:35:0)
[10:23:19.446] Timer tick, asking Buildbucket for the build status
[10:23:19.537] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:19.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:36:0) after 1m0s
[10:24:19.509] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:36:0)
[10:24:19.509] Timer tick, asking Buildbucket for the build status
[10:24:19.639] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:19.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:37:0) after 1m0s
[10:25:19.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:37:0)
[10:25:19.732] Timer tick, asking Buildbucket for the build status
[10:25:20.498] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:20.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:38:0) after 1m0s
[10:26:20.562] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:38:0)
[10:26:20.562] Timer tick, asking Buildbucket for the build status
[10:26:21.299] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:21.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:39:0) after 1m0s
[10:27:21.381] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:39:0)
[10:27:21.381] Timer tick, asking Buildbucket for the build status
[10:27:21.543] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:21.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:40:0) after 1m0s
[10:28:21.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:40:0)
[10:28:21.551] Timer tick, asking Buildbucket for the build status
[10:28:21.658] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:21.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:41:0) after 1m0s
[10:29:21.699] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:41:0)
[10:29:21.699] Timer tick, asking Buildbucket for the build status
[10:29:21.783] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:21.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:42:0) after 1m0s
[10:30:21.854] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:42:0)
[10:30:21.855] Timer tick, asking Buildbucket for the build status
[10:30:21.950] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:21.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:43:0) after 1m0s
[10:31:21.968] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:43:0)
[10:31:21.968] Timer tick, asking Buildbucket for the build status
[10:31:22.039] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:22.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:44:0) after 1m0s
[10:32:22.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:44:0)
[10:32:22.066] Timer tick, asking Buildbucket for the build status
[10:32:22.152] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:22.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:45:0) after 1m0s
[10:33:22.195] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:45:0)
[10:33:22.195] Timer tick, asking Buildbucket for the build status
[10:33:23.423] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:23.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:46:0) after 1m0s
[10:34:23.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:46:0)
[10:34:23.434] Timer tick, asking Buildbucket for the build status
[10:34:23.516] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:23.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:47:0) after 1m0s
[10:35:23.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:47:0)
[10:35:23.535] Timer tick, asking Buildbucket for the build status
[10:35:23.628] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:23.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:48:0) after 1m0s
[10:36:23.632] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:48:0)
[10:36:23.632] Timer tick, asking Buildbucket for the build status
[10:36:23.852] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:23.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:49:0) after 1m0s
[10:37:23.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:49:0)
[10:37:23.853] Timer tick, asking Buildbucket for the build status
[10:37:23.927] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:23.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:50:0) after 1m0s
[10:38:23.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:50:0)
[10:38:23.992] Timer tick, asking Buildbucket for the build status
[10:38:24.112] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:24.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:51:0) after 1m0s
[10:39:24.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:51:0)
[10:39:24.130] Timer tick, asking Buildbucket for the build status
[10:39:24.525] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:24.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:52:0) after 1m0s
[10:40:24.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:52:0)
[10:40:24.544] Timer tick, asking Buildbucket for the build status
[10:40:24.806] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:24.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:53:0) after 1m0s
[10:41:24.858] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:53:0)
[10:41:24.858] Timer tick, asking Buildbucket for the build status
[10:41:24.954] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:24.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:54:0) after 1m0s
[10:42:24.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:54:0)
[10:42:24.999] Timer tick, asking Buildbucket for the build status
[10:42:25.511] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:25.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:55:0) after 1m0s
[10:43:25.578] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:55:0)
[10:43:25.578] Timer tick, asking Buildbucket for the build status
[10:43:25.749] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:25.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:56:0) after 1m0s
[10:44:25.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:56:0)
[10:44:25.716] Timer tick, asking Buildbucket for the build status
[10:44:27.112] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:27.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:57:0) after 1m0s
[10:45:27.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:57:0)
[10:45:27.159] Timer tick, asking Buildbucket for the build status
[10:45:27.246] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:27.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:58:0) after 1m0s
[10:46:27.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:58:0)
[10:46:27.321] Timer tick, asking Buildbucket for the build status
[10:46:27.391] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:27.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:59:0) after 1m0s
[10:47:27.386] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:59:0)
[10:47:27.386] Timer tick, asking Buildbucket for the build status
[10:47:27.636] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:27.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:60:0) after 1m0s
[10:48:27.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:60:0)
[10:48:27.655] Timer tick, asking Buildbucket for the build status
[10:48:29.012] Build 8853880477552265008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:29.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019310539553038800:61:0) after 1m0s
[10:48:45.370] Received PubSub notification, asking Buildbucket for the build status
[10:48:45.722] Build 8853880477552265008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:48:45.722] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614682124213257",
"created_by": "project:chromium",
"created_ts": "1614678610235015",
"id": "8853880477552265008",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8749215a7b33eceb7f0fcc5b7081a6944799d754\"}}",
"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\": \"8749215a7b33eceb7f0fcc5b7081a6944799d754\", \"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-1-qhp0\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17589, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-3\", \"got_angle_revision\": \"6b6da203cce03287ef269846d54e77a8e871e221\", \"got_dawn_revision\": \"ec3f48242250668ca510ceef7336cf93ba80faa5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"8749215a7b33eceb7f0fcc5b7081a6944799d754\", \"got_revision_cp\": \"refs/heads/master@{#858943}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"e354dd1ed9d1e7e05e1365116b09a5a232ae8a86\", \"got_v8_revision_cp\": \"refs/heads/9.1.13@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"8749215a7b33eceb7f0fcc5b7081a6944799d754\", \"swarm_hashes_refs/heads/master(at){#858943}_without_patch\": {\"absl_hardening_tests\": \"c01035acad2dfba3781275cd59af314acb39fc87\", \"accessibility_unittests\": \"c66cf6de40ee4152026912662d96e7a4bcba506f\", \"angle_unittests\": \"fad3c73fe75326bb64bff2cbb4ae56cef6973b2d\", \"app_shell_unittests\": \"f2f43dba21624a3642a39f3039793e4420b2b921\", \"aura_unittests\": \"a950872f562185f5a92b365ecae3fb4d10a7c1b9\", \"base_unittests\": \"424fc5323dc0eee8f74c3b52893d266301cc86ce\", \"base_util_unittests\": \"b90bc630d4852fae36d703cb49af6c405375910c\", \"blink_common_unittests\": \"05d1cd3f022287ce6ad745272a1304055b8b9335\", \"blink_fuzzer_unittests\": \"cb2fe8c348f4335cc38697bfeaf7a17482ce87db\", \"blink_heap_unittests\": \"757c2ddb69d530086b2e327cabeb23b0509985cb\", \"blink_platform_unittests\": \"5317b8cf604f12631204a27abcf5b491567c7601\", \"blink_unittests\": \"8014117a18e234d8586aa4d8d878b6032fb77b82\", \"boringssl_crypto_tests\": \"d82758f809c4bf087c422f55008135e6b52c4a1e\", \"boringssl_ssl_tests\": \"30ee380e42f46179de34d16e233dca2a9ea50558\", \"browser_switcher_bho_unittests\": \"f2230c66177d01ddc59524d13b329623368b48aa\", \"browser_tests\": \"eed4de6e60dc3f32e4e2ede95262e126fc43035b\", \"capture_unittests\": \"6b48cf59b5ac41737792867cccc81bf81172291d\", \"cast_unittests\": \"adb2206fa5e39981307a43367d462d70237efe84\", \"cc_unittests\": \"8b356c66ceb1edea30737a4b0dab212b261ac092\", \"chrome_app_unittests\": \"5ba4c162c8242210dcd121f3f77f903f8055449b\", \"chrome_cleaner_unittests\": \"cd3c5aa6f1e3bff1fd4589e8896e22b8c4bf1c39\", \"chrome_elf_unittests\": \"cff41ca5d960567d859b688e9752a97e3305af36\", \"chromedriver_unittests\": \"6ff0ff17d9b9e46ead12ce04d7312a892d5b6e4e\", \"color_unittests\": \"320bbfb68a81a4441cf1a68964cb6d81f79e7a5e\", \"components_browsertests\": \"949326bffba58f93ccab36ac8f290881b2650d8a\", \"components_unittests\": \"456ea8f7ee24d3744cbd44d6bbac78521e9d1415\", \"compositor_unittests\": \"4570bd3ef455b5747aab3846840bf4504a5d7f65\", \"content_browsertests\": \"d9ac6af698a46917124d951996578084a0e79b4f\", \"content_unittests\": \"695c3416ea29d810b995bc10ccef3500f3ec5a7c\", \"courgette_unittests\": \"b220c45e91ec385c052ba07cfe753f73068fa90a\", \"crashpad_tests\": \"4fc801f3a21a71e51c8e182a7fe8299e9d09e656\", \"cronet_tests\": \"8f7c530c4ef30b8b3c130872dd41d67333a342f2\", \"cronet_unittests\": \"95dd39a679dca0011f5e1c0facc88bca85b3cdff\", \"crypto_unittests\": \"71ca496a52779c652ea7da91a7d3f81e76cc9cfe\", \"delayloads_unittests\": \"24e0f545051a2a8803b1f05b572f7a78b9a12cd0\", \"device_unittests\": \"16be4b77ebbd78a2bc93d15535cd33f609f1952d\", \"display_unittests\": \"86b266efebcff6231d1eb477debb29a92ee690d4\", \"elevation_service_unittests\": \"17584a7a7e99bc02e52e97399efe329e2a0bf78a\", \"events_unittests\": \"ee8fdbc472ce2c4b1a7e094f4e86b317f7b35149\", \"extensions_browsertests\": \"ea9bb1f0271dc0777d8bec0360c496c0d3a35822\", \"extensions_unittests\": \"3ed8b05c107b3c0c86b745f598b70cc1a9c03049\", \"filesystem_service_unittests\": \"dd8810e5916125d886a18feb41642b6bd2f13c0e\", \"gcm_unit_tests\": \"61e2313a1f77c10e5c063dc70ae6fcfe55d33636\", \"gcp_unittests\": \"0bb41f76dcc01b980d0fa4adbe14c4f2119e8605\", \"gfx_unittests\": \"cd6f3b560a9664946bb28b5bf9f3d29a6f1cbbc2\", \"gin_unittests\": \"a20e1e9560f39a0708069ff71137b01bcd033615\", \"google_apis_unittests\": \"002f51ebee19d68b3412b33e269a0be4daccb446\", \"gpu_unittests\": \"e5c113a5d1a6c4eeda061bc3ea44180c935bb8ab\", \"gwp_asan_unittests\": \"6edaf29c557a308d2da1d8da7346ac055b1a1aa9\", \"headless_browsertests\": \"28e7adefc1751af79c895f038e5079e98bdc248a\", \"headless_unittests\": \"4948d163a53e1220e3d70d650afa2a39bbe30626\", \"install_static_unittests\": \"57af4a4f198df5a319218334c92f6b55f8eebd34\", \"installer_util_unittests\": \"c4d51393fe8b44d58aa032bf279e52377944cd87\", \"interactive_ui_tests\": \"55f97ab84f3d59445f10524847f586fc3325ab9b\", \"ipc_tests\": \"1af7cc82e293ffc7a5fff2669417382232d9988f\", \"jingle_unittests\": \"48980d316056c9d233c0b76c98188797f90725f4\", \"latency_unittests\": \"d3cdeefd05ec6ef17d2152aa6fa6e2091727af5d\", \"libjingle_xmpp_unittests\": \"1f700122098d12469cf6a6be8f8d4687c7b5ed4c\", \"liburlpattern_unittests\": \"b623ae7c0d867683f96d4823e12ccca1a8ff60c2\", \"media_blink_unittests\": \"9270ef37e1e21872c8ff4d24a0f592d4bc37bba3\", \"media_unittests\": \"bc48b61049e29d68a468ce3421d9995ff23d40eb\", \"message_center_unittests\": \"137ddde2d0f0975f31234e6640b5c4524e32526b\", \"midi_unittests\": \"7eaabdfa23a030d5aebfd8878bf9bff2bb19faf1\", \"mojo_core_unittests\": \"3f3d7d12ba0725674c9acde42af3281362f58290\", \"mojo_unittests\": \"e3006678d23dece29b21456eababd6525b3cc2a5\", \"nacl_loader_unittests\": \"b90fe61c94c6d9345c505c9b14ed64709f7ab8ba\", \"native_theme_unittests\": \"d61f84eb8e45861c0e60ad6983e479d7b19c896d\", \"net_unittests\": \"63f0cecb8543ee140b5fe36622a90c49f0744332\", \"notification_helper_unittests\": \"58eec2db46089195a703179246fa73df494e4b48\", \"pdf_unittests\": \"2abe702057aa237f61e0d275810c0a2fed978553\", \"perfetto_unittests\": \"b6154d9ec0cf5d6a66fd0710cf8a24d8f09f0f01\", \"ppapi_unittests\": \"36638591bb6cb4c9ada85b5834566dc5d046f51d\", \"printing_unittests\": \"4872b09aa6a4b5d47759863577e3d97f371839ed\", \"remoting_unittests\": \"02e303dadd3751465c765ba94e2962281c3070ec\", \"sbox_integration_tests\": \"04d06121508fb2d2facaa786824dd806b2f1a19c\", \"sbox_unittests\": \"9f06d69c0c045ecaad9f2a8f6f82dc4d837aa0d0\", \"sbox_validation_tests\": \"2d7d63b87b9b3d69f5056b18bc59616b611a956c\", \"service_manager_unittests\": \"9829376b0a5ab9887e1f60b088063f3384befacc\", \"services_unittests\": \"9514556d76d3d2d0c5a5794b4c870677a550b679\", \"setup_unittests\": \"bc37d1eaa7161ff1df3e81a8e4a2203f76278dbf\", \"shell_dialogs_unittests\": \"c43d95950989fd37981031af9e0b39fe7b83f314\", \"skia_unittests\": \"2e98bb28654474024999c082d226207841deef47\", \"snapshot_unittests\": \"eb1f65cdc213aa0a8152f71a21fb1227c09fad0a\", \"sql_unittests\": \"baba5f5f4d8052c406a5c1434c939f30234c7dc5\", \"storage_unittests\": \"f3c5a5e2e129ea7d783e483a28065b8b6a4e287a\", \"sync_integration_tests\": \"2d205b02b3959599e9aeccada7f791e343643d71\", \"traffic_annotation_auditor_unittests\": \"03f9b05802e8ec2b9dfecdf49e4cbd51b37668a9\", \"ui_base_unittests\": \"314ac198558630723e113447ddc1791e7551d650\", \"ui_touch_selection_unittests\": \"d77b22ef36b4ca281b48848d0e6ab5d5ed5629aa\", \"unit_tests\": \"aa66e1b2e72980d7e3194d2b8246d6c8ddaa2018\", \"updater_tests\": \"41fdef939eee3714a67f34a41ad275c97fad3a2f\", \"url_unittests\": \"5746f029875e91ed6017e1225e363bdc01d48d31\", \"views_unittests\": \"b5e54b5c384388ff291dbd92fa3795f4f71ad19d\", \"viz_unittests\": \"c72ff733d30f658ba37a312e8ca6120785939a3e\", \"vr_common_unittests\": \"03ee819a99c2b9eed644bcc0e9a2aff1c9f2a1fb\", \"vr_pixeltests\": \"b62041d27b19d30195bab5bbdad9b66e330800f0\", \"weblayer_browsertests\": \"f4d59d914eb1745f5177c41e0b8973e088afb2fa\", \"weblayer_unittests\": \"14695e1ce99b6fc9c22e5b9ae2336659bbbdf40a\", \"wm_unittests\": \"db6ced64ffacc9c20d83d6c408943a3d5b9b1230\", \"wtf_unittests\": \"8d16c571fc3dc51dd9edb23c61391dc890c2643f\", \"zlib_unittests\": \"1f51f92160e696ad8ff428da42fff76c609c3e97\", \"zucchini_unittests\": \"5345fc2475cba90eebd3f3d5761432645793b2fe\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02613bacee8cd1c41158238da4ce7615021ecb28a4b52e6029f89cb601af0790_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-1-qhp0\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5725-1a0d85e\"], \"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": "1614678612990743",
"status": "COMPLETED",
"status_changed_ts": "1614682124430750",
"tags": [
"build_address:luci.chromium.ci/win-asan/17589",
"builder:win-asan",
"buildset:commit/git/8749215a7b33eceb7f0fcc5b7081a6944799d754",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8749215a7b33eceb7f0fcc5b7081a6944799d754",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019310539553038800",
"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/8853880477552265008/+/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:520b29dba50b4010",
"user_agent:luci-scheduler"
],
"updated_ts": "1614682124434607",
"url": "https://ci.chromium.org/b/8853880477552265008",
"utcnow_ts": "1614682125704210"
}
}
[10:48:45.722] Invocation finished in 58m36.778418258s with status SUCCEEDED