[11:11:12.521] New invocation is queued and will start shortly
[11:11:13.658] Starting the invocation (attempt 1)
[11:11:13.703] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:11:13.703] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:11:13.703] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025737824352439696",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"fd08c4c4548c0b9a4f850aba8b7a46c0a993d523\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9025737824352439696",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/fd08c4c4548c0b9a4f850aba8b7a46c0a993d523",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd08c4c4548c0b9a4f850aba8b7a46c0a993d523",
"gitiles_ref:refs/heads/master"
]
}
[11:11:14.946] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608549073866367",
"id": "8860307762280091408",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fd08c4c4548c0b9a4f850aba8b7a46c0a993d523\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608549074795485",
"tags": [
"build_address:luci.chromium.ci/win-asan/16361",
"builder:win-asan",
"buildset:commit/git/fd08c4c4548c0b9a4f850aba8b7a46c0a993d523",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd08c4c4548c0b9a4f850aba8b7a46c0a993d523",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025737824352439696",
"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/8860307762280091408/+/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": "1608549074795644",
"url": "https://ci.chromium.org/b/8860307762280091408",
"utcnow_ts": "1608549074939928"
}
}
[11:11:14.946] Task URL: https://ci.chromium.org/b/8860307762280091408
[11:11:14.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:2:0) after 1m0s
[11:11:18.710] Received PubSub notification, asking Buildbucket for the build status
[11:11:18.773] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:14.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:2:0)
[11:12:14.981] Timer tick, asking Buildbucket for the build status
[11:12:15.148] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:15.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:4:0) after 1m0s
[11:13:15.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:4:0)
[11:13:15.196] Timer tick, asking Buildbucket for the build status
[11:13:15.383] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:15.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:5:0) after 1m0s
[11:14:15.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:5:0)
[11:14:15.432] Timer tick, asking Buildbucket for the build status
[11:14:22.634] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:22.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:6:0) after 1m0s
[11:15:22.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:6:0)
[11:15:22.711] Timer tick, asking Buildbucket for the build status
[11:15:22.968] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:22.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:7:0) after 1m0s
[11:16:22.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:7:0)
[11:16:22.992] Timer tick, asking Buildbucket for the build status
[11:16:23.133] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:23.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:8:0) after 1m0s
[11:17:23.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:8:0)
[11:17:23.179] Timer tick, asking Buildbucket for the build status
[11:17:23.523] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:23.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:9:0) after 1m0s
[11:18:23.624] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:9:0)
[11:18:23.624] Timer tick, asking Buildbucket for the build status
[11:18:23.692] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:23.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:10:0) after 1m0s
[11:19:23.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:10:0)
[11:19:23.791] Timer tick, asking Buildbucket for the build status
[11:19:23.902] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:23.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:11:0) after 1m0s
[11:20:23.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:11:0)
[11:20:23.978] Timer tick, asking Buildbucket for the build status
[11:20:24.032] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:24.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:12:0) after 1m0s
[11:21:24.183] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:12:0)
[11:21:24.183] Timer tick, asking Buildbucket for the build status
[11:21:24.332] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:24.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:13:0) after 1m0s
[11:22:24.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:13:0)
[11:22:24.378] Timer tick, asking Buildbucket for the build status
[11:22:24.474] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:24.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:14:0) after 1m0s
[11:23:24.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:14:0)
[11:23:24.630] Timer tick, asking Buildbucket for the build status
[11:23:24.943] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:24.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:15:0) after 1m0s
[11:24:24.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:15:0)
[11:24:24.966] Timer tick, asking Buildbucket for the build status
[11:24:25.040] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:25.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:16:0) after 1m0s
[11:25:25.145] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:16:0)
[11:25:25.145] Timer tick, asking Buildbucket for the build status
[11:25:25.368] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:25.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:17:0) after 1m0s
[11:26:25.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:17:0)
[11:26:25.534] Timer tick, asking Buildbucket for the build status
[11:26:25.668] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:25.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:18:0) after 1m0s
[11:27:25.700] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:18:0)
[11:27:25.700] Timer tick, asking Buildbucket for the build status
[11:27:25.950] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:25.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:19:0) after 1m0s
[11:28:26.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:19:0)
[11:28:26.138] Timer tick, asking Buildbucket for the build status
[11:28:26.274] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:26.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:20:0) after 1m0s
[11:29:26.642] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:20:0)
[11:29:26.642] Timer tick, asking Buildbucket for the build status
[11:29:26.755] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:26.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:21:0) after 1m0s
[11:30:26.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:21:0)
[11:30:26.914] Timer tick, asking Buildbucket for the build status
[11:30:27.086] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:27.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:22:0) after 1m0s
[11:31:27.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:22:0)
[11:31:27.223] Timer tick, asking Buildbucket for the build status
[11:31:27.373] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:27.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:23:0) after 1m0s
[11:32:27.427] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:23:0)
[11:32:27.427] Timer tick, asking Buildbucket for the build status
[11:32:27.554] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:27.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:24:0) after 1m0s
[11:33:27.559] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:24:0)
[11:33:27.559] Timer tick, asking Buildbucket for the build status
[11:33:27.688] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:27.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:25:0) after 1m0s
[11:34:27.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:25:0)
[11:34:27.714] Timer tick, asking Buildbucket for the build status
[11:34:27.845] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:27.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:26:0) after 1m0s
[11:35:27.987] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:26:0)
[11:35:27.987] Timer tick, asking Buildbucket for the build status
[11:35:28.054] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:28.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:27:0) after 1m0s
[11:36:28.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:27:0)
[11:36:28.167] Timer tick, asking Buildbucket for the build status
[11:36:28.283] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:28.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:28:0) after 1m0s
[11:37:29.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:28:0)
[11:37:29.133] Timer tick, asking Buildbucket for the build status
[11:37:29.194] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:29.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:29:0) after 1m0s
[11:38:29.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:29:0)
[11:38:29.454] Timer tick, asking Buildbucket for the build status
[11:38:29.682] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:29.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:30:0) after 1m0s
[11:39:29.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:30:0)
[11:39:29.728] Timer tick, asking Buildbucket for the build status
[11:39:30.130] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:30.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:31:0) after 1m0s
[11:40:31.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:31:0)
[11:40:31.572] Timer tick, asking Buildbucket for the build status
[11:40:31.755] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:31.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:32:0) after 1m0s
[11:41:31.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:32:0)
[11:41:31.764] Timer tick, asking Buildbucket for the build status
[11:41:31.928] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:31.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:33:0) after 1m0s
[11:42:31.988] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:33:0)
[11:42:31.988] Timer tick, asking Buildbucket for the build status
[11:42:32.304] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:32.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:34:0) after 1m0s
[11:43:32.467] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:34:0)
[11:43:32.467] Timer tick, asking Buildbucket for the build status
[11:43:32.611] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:32.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:35:0) after 1m0s
[11:44:32.661] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:35:0)
[11:44:32.661] Timer tick, asking Buildbucket for the build status
[11:44:32.738] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:32.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:36:0) after 1m0s
[11:45:32.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:36:0)
[11:45:32.853] Timer tick, asking Buildbucket for the build status
[11:45:32.952] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:32.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:37:0) after 1m0s
[11:46:33.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:37:0)
[11:46:33.178] Timer tick, asking Buildbucket for the build status
[11:46:33.293] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:33.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:38:0) after 1m0s
[11:47:33.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:38:0)
[11:47:33.448] Timer tick, asking Buildbucket for the build status
[11:47:33.573] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:33.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:39:0) after 1m0s
[11:48:33.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:39:0)
[11:48:33.695] Timer tick, asking Buildbucket for the build status
[11:48:33.774] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:33.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:40:0) after 1m0s
[11:49:33.881] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:40:0)
[11:49:33.881] Timer tick, asking Buildbucket for the build status
[11:49:34.028] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:34.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:41:0) after 1m0s
[11:50:34.110] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:41:0)
[11:50:34.110] Timer tick, asking Buildbucket for the build status
[11:50:34.263] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:34.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:42:0) after 1m0s
[11:51:34.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:42:0)
[11:51:34.435] Timer tick, asking Buildbucket for the build status
[11:51:34.547] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:34.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:43:0) after 1m0s
[11:52:34.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:43:0)
[11:52:34.583] Timer tick, asking Buildbucket for the build status
[11:52:34.687] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:34.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:44:0) after 1m0s
[11:53:34.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:44:0)
[11:53:34.876] Timer tick, asking Buildbucket for the build status
[11:53:34.954] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:34.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:45:0) after 1m0s
[11:54:35.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:45:0)
[11:54:35.032] Timer tick, asking Buildbucket for the build status
[11:54:35.145] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:35.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:46:0) after 1m0s
[11:55:35.406] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:46:0)
[11:55:35.406] Timer tick, asking Buildbucket for the build status
[11:55:35.525] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:35.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:47:0) after 1m0s
[11:56:35.661] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:47:0)
[11:56:35.661] Timer tick, asking Buildbucket for the build status
[11:56:35.795] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:35.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:48:0) after 1m0s
[11:57:35.879] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:48:0)
[11:57:35.879] Timer tick, asking Buildbucket for the build status
[11:57:35.991] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:35.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:49:0) after 1m0s
[11:58:36.105] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:49:0)
[11:58:36.105] Timer tick, asking Buildbucket for the build status
[11:58:36.436] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:36.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:50:0) after 1m0s
[11:59:36.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:50:0)
[11:59:36.495] Timer tick, asking Buildbucket for the build status
[11:59:36.713] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:36.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:51:0) after 1m0s
[12:00:36.746] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:51:0)
[12:00:36.746] Timer tick, asking Buildbucket for the build status
[12:00:36.848] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:36.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:52:0) after 1m0s
[12:01:36.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:52:0)
[12:01:36.897] Timer tick, asking Buildbucket for the build status
[12:01:37.008] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:37.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:53:0) after 1m0s
[12:02:37.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:53:0)
[12:02:37.223] Timer tick, asking Buildbucket for the build status
[12:02:37.368] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:37.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:54:0) after 1m0s
[12:03:37.479] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:54:0)
[12:03:37.479] Timer tick, asking Buildbucket for the build status
[12:03:37.558] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:37.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:55:0) after 1m0s
[12:04:37.647] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:55:0)
[12:04:37.647] Timer tick, asking Buildbucket for the build status
[12:04:37.754] Build 8860307762280091408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:37.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025737824352439696:56:0) after 1m0s
[12:04:56.161] Received PubSub notification, asking Buildbucket for the build status
[12:04:56.501] Build 8860307762280091408: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:04:56.502] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608552295142051",
"created_by": "project:chromium",
"created_ts": "1608549073866367",
"id": "8860307762280091408",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fd08c4c4548c0b9a4f850aba8b7a46c0a993d523\"}}",
"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\": \"fd08c4c4548c0b9a4f850aba8b7a46c0a993d523\", \"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-us-central1-b-32-1-a7av\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16361, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"ed9213bca0643edb65b7d39a938210419398a1b3\", \"got_dawn_revision\": \"5d4fd88a7403aa255d49919d011af54c691b344a\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"fd08c4c4548c0b9a4f850aba8b7a46c0a993d523\", \"got_revision_cp\": \"refs/heads/master@{#838627}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"b96d7e2a4be85264b9cd7ba26d91f7fb98baa9a5\", \"got_v8_revision_cp\": \"refs/heads/8.9.179@{#1}\", \"got_webrtc_revision\": \"ef9c4e07a351c9396c72e72efaa1be3df728c440\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32863}\", \"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\": \"fd08c4c4548c0b9a4f850aba8b7a46c0a993d523\", \"swarm_hashes_refs/heads/master(at){#838627}_without_patch\": {\"absl_hardening_tests\": \"82850a7f813fd9a083ed7982c7443a5c5aaee4ca\", \"accessibility_unittests\": \"127207dceef45ad2d3a84bf134683a72d6d40a6c\", \"angle_unittests\": \"86a3de7a02783075a45326a2784699c67f87ca5b\", \"app_shell_unittests\": \"2ed4452d280a847090d129668435751c3b16c8be\", \"aura_unittests\": \"6a615ea53ebbc5440b746bbc52c367038e46648c\", \"base_unittests\": \"fc06ef66046e8924a972ca2fa6d4a78aa00f734e\", \"base_util_unittests\": \"97ef970a49bb03884aa200b47428c94f744a4334\", \"blink_common_unittests\": \"b15eab41ef53172324a24d94d9c13ef12980ec3a\", \"blink_fuzzer_unittests\": \"d74839c4289d39a605f39f35cd97c4fb0be89103\", \"blink_heap_unittests\": \"5034a81585507f17ea69aac6b7fa0fa13de25f71\", \"blink_platform_unittests\": \"0f85c51c2a86f7cd4567d3bc4c4b1895a3a4ac97\", \"blink_unittests\": \"bb7d83de67b49184294eb336162729c493954240\", \"boringssl_crypto_tests\": \"b5f43e4915c555f0f0a79a2e7a89dff7d4ae57c8\", \"boringssl_ssl_tests\": \"4b332d518ca3d3ce5532690fbc210ee41572403f\", \"browser_switcher_bho_unittests\": \"31cd18d8b1eec89e415b331a9d408f1e0dc312e8\", \"browser_tests\": \"7722aaa6d2b7b7bd7e06e11c5a5ba464276a3514\", \"capture_unittests\": \"88ef7ed7dd40c83ee92bb7d8925007dd807c6d8b\", \"cast_unittests\": \"1e0352a931ae44ef1bd5ff7e7c94e34f5921eced\", \"cc_unittests\": \"42cb6e6c1b49f73e44fd8f12568654f88309b0f6\", \"chrome_app_unittests\": \"d8a486761ec4d1d5037a7875bd0f5aa66f44b6f7\", \"chrome_cleaner_unittests\": \"0a89e457fd320c1c5b39842afe259f8a36cff6cf\", \"chrome_elf_unittests\": \"f8097796d66f0f130d518f1776215cd9b6d738b2\", \"chromedriver_unittests\": \"026f28a5a6b0e545617d3bd7773df4c9904d36da\", \"components_browsertests\": \"c2582801fc73926366c2f055a31b7052b34b5023\", \"components_unittests\": \"27ae64ff79bd9d972f7bb475af25d5329021a66b\", \"compositor_unittests\": \"d3295a5bc1d615a64cf13a4db03e10067782c491\", \"content_browsertests\": \"4106cb8cbcc4798da6942deb7d09b72265fca352\", \"content_unittests\": \"7de756131b48b8dd87faf41c964ee3840e1fb26b\", \"courgette_unittests\": \"853d8778587fdee67067bccccaaac69f4d6451f0\", \"crashpad_tests\": \"7a0f8e6f613f70c00737a1e0e0abbe0b1eb87f81\", \"cronet_tests\": \"92c7136bf72828149ded99a1077bde5fbb55ea34\", \"cronet_unittests\": \"7264acaec5f29ec22921784c1c71ce771d209f0d\", \"crypto_unittests\": \"bf030e9230c3f3b4fd1feaf333da15001844c088\", \"delayloads_unittests\": \"2b85d3e730ef60f03b189482ec9e90887d8f3b5a\", \"device_unittests\": \"effbdf0671bbaa6dce8d62ecafb9a3da9fd89e8e\", \"display_unittests\": \"dfe57c1a0eb3aa9551a397149011737a39a1e920\", \"elevation_service_unittests\": \"3a6910fe9fc8be3c3166ad3d9246b48fbe8a9e66\", \"events_unittests\": \"a01d6a19f7458b8d5d46eb07a6a48dca76660e39\", \"extensions_browsertests\": \"7aacc35eae9f9040804022277f8e0fa6c7100d89\", \"extensions_unittests\": \"298248505d0066a59df9ddff9a4c1f64328af70a\", \"filesystem_service_unittests\": \"25e6aa51f80d794f42ea2f62729ccbfaa938d994\", \"gcm_unit_tests\": \"898c342f69ca1ac9b30b9c765318745453dc04bf\", \"gcp_unittests\": \"30b1baec1108fc7c50e0b1cc27bf002361230c14\", \"gfx_unittests\": \"2a4ca9379d87674d4a57b741b66e2d177a4872df\", \"gin_unittests\": \"568af2b613a765cc32f48ba8fbaaec6f35899e9f\", \"google_apis_unittests\": \"d065f568f5b660ec611a70b9df35bca9ea91dfb5\", \"gpu_unittests\": \"5dda19d6d1a69d05a7b01d807003d2ad78d0363c\", \"gwp_asan_unittests\": \"6b102e4d9335c1f6241800a7558034dcf5d17124\", \"headless_browsertests\": \"5a2f7e94883edd9013518939ce76d498fb96bef9\", \"headless_unittests\": \"998a925cc1a383de6339ca7905c183cefeb63e28\", \"install_static_unittests\": \"1279ac7f9c508c934448f8e2eaa424bdaf8bedf9\", \"installer_util_unittests\": \"34cc549bd205098310bc6fb8c0e6d080e7356145\", \"interactive_ui_tests\": \"e947adea9e1d2d68b4f85e098aa600a55f3a0682\", \"ipc_tests\": \"53adbb019a421c00d3a485e6af34308ce5e7ba7a\", \"jingle_unittests\": \"1cb0b472a7c62e6cc5098eb63da94a218495c254\", \"latency_unittests\": \"15458416187bf26a8a34d6f78337da9b9f0d0db4\", \"libjingle_xmpp_unittests\": \"d5d8bdf34e77507faaa1d41aea3c03f68e01ee2a\", \"liburlpattern_unittests\": \"d3b46ec2546283c045454e49a2aa112f8950e297\", \"media_blink_unittests\": \"e8fc5e6f31aef32dd093dacef155cfd2d74d968a\", \"media_unittests\": \"21410881f266962163d7ccf6768e275ed0945edf\", \"message_center_unittests\": \"cb114e037984af4b306e556d4f58034c03537090\", \"midi_unittests\": \"f5530a0392942a800ff1db9dc955bd377ded85cd\", \"mojo_core_unittests\": \"d5191911cbf3f3b3f97c25abaa9be4e9a473ea82\", \"mojo_unittests\": \"58a7fe21a7d4d632f832ff6e8a36132467f21191\", \"nacl_loader_unittests\": \"668c81c83c0b800d23a5c07195e12a42f0b7ffa5\", \"native_theme_unittests\": \"d0077fde920875e4d7ceca1e7c58ae6d6087f27e\", \"net_unittests\": \"7c649bc24fee8ac5d69e50ee24186ad364d08b98\", \"notification_helper_unittests\": \"b886aeb68c889466e10a379c8415e6afce02edc6\", \"pdf_unittests\": \"03c1bb0109cdbe5f69c61661ffb6d481dbd22ac5\", \"perfetto_unittests\": \"c8f84016658b36689c6c78d3e23e4a33f11499a6\", \"ppapi_unittests\": \"295b3f4f761a74b33f01787be3f6759e77360d7d\", \"printing_unittests\": \"ae82aa4ae475f014a092a0f73b5d62d5a4e24fad\", \"remoting_unittests\": \"c659ddfd93453774f5e4475a7fe561acf15c0d03\", \"sbox_integration_tests\": \"c570856925d59b43869ae38932ee32322ebee7fb\", \"sbox_unittests\": \"9e81a0f6533bb11d314f046736673f8c2c70fafc\", \"sbox_validation_tests\": \"c4c0c79337def2aeb065af89092006b488733831\", \"service_manager_unittests\": \"52049ac25c4d5aeabcca25d8925760fc87b11cf1\", \"services_unittests\": \"a0813266912ae12fb875de2461fd0fdbd7bce66f\", \"setup_unittests\": \"7ac93fcc646f7882c0aca79ff9aea4410bb5aeee\", \"shell_dialogs_unittests\": \"c1b7cf59c0b020ded94c3e7f20463571a850a62e\", \"skia_unittests\": \"7f82a11969b4c48ea45523e2aaed6eec1d3b3034\", \"snapshot_unittests\": \"aade2c2c1790802168c0d04078ddd862cf8e6dcf\", \"sql_unittests\": \"02c60f17060abab4a6b2a8ead6bf7ddec13d842a\", \"storage_unittests\": \"ced773d258866cc25d4c3d45234df44d3012569e\", \"sync_integration_tests\": \"f43b4045d55698340a483f818aa92adbbd6fe830\", \"traffic_annotation_auditor_unittests\": \"719ba234b50acbaef038e98eaa84b4f21f895a68\", \"ui_base_unittests\": \"8607c10c00f59c3bbb251c6eabc95b57663ffee1\", \"ui_touch_selection_unittests\": \"039f2d72d9f3655c6844929aca2799612c5bd572\", \"unit_tests\": \"4815848786245adc7dd1e4f98589c9a3079ddf95\", \"updater_tests\": \"a0ebee8504d229c0fa4b877c8512d3d60438892e\", \"url_unittests\": \"99ca02adfc8f11d972c6f0e1b530c55b41f6a633\", \"views_unittests\": \"905f0d9d2e747e754567dcd72ba9320252e08970\", \"viz_unittests\": \"d06eef9683b7e559f2ac4547baa906f3890ebe95\", \"vr_common_unittests\": \"773cfd824e2564c04a6b2e410dfb7044d57bb339\", \"vr_pixeltests\": \"37ab9792b251bac4ba5600c31a09cb1af3cdeef1\", \"weblayer_browsertests\": \"b68b67c701a3ccd12f8b45e40a3e6a30d6bcf1ec\", \"weblayer_unittests\": \"47ca917d848a4becbb094a806970e0932e9cc1e6\", \"wm_unittests\": \"2eaa16d5983a752214ee07bf565773ddb9fdaf49\", \"wtf_unittests\": \"9780049e700ae94207bd5a5a6a974c8c1461c8b7\", \"zlib_unittests\": \"0ff49215505f0060c1f23b43c974c5837a77553a\", \"zucchini_unittests\": \"5d8eb9ac0295c1d97fbad4dd7a79661e742da33c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_91b2ef8341586e76bd64fa3093e74ce43aef344c2e2134fb3b046b47c3d4bcdb_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-a7av\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608549078135402",
"status": "COMPLETED",
"status_changed_ts": "1608552295690819",
"tags": [
"build_address:luci.chromium.ci/win-asan/16361",
"builder:win-asan",
"buildset:commit/git/fd08c4c4548c0b9a4f850aba8b7a46c0a993d523",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd08c4c4548c0b9a4f850aba8b7a46c0a993d523",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025737824352439696",
"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/8860307762280091408/+/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:509dd09213458210",
"user_agent:luci-scheduler"
],
"updated_ts": "1608552295696586",
"url": "https://ci.chromium.org/b/8860307762280091408",
"utcnow_ts": "1608552296478721"
}
}
[12:04:56.502] Invocation finished in 53m43.996058699s with status SUCCEEDED