[01:13:27.592] New invocation is queued and will start shortly
[01:13:28.660] Starting the invocation (attempt 1)
[01:13:28.693] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:13:28.693] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:13:28.693] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023782298197102672",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b6de0c06998876af4708a02ddbea696a4a5902eb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023782298197102672",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/b6de0c06998876af4708a02ddbea696a4a5902eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b6de0c06998876af4708a02ddbea696a4a5902eb",
"gitiles_ref:refs/heads/master"
]
}
[01:13:29.475] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610414008817874",
"id": "8858352236248570080",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b6de0c06998876af4708a02ddbea696a4a5902eb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610414009347292",
"tags": [
"build_address:luci.chromium.ci/win-asan/16766",
"builder:win-asan",
"buildset:commit/git/b6de0c06998876af4708a02ddbea696a4a5902eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b6de0c06998876af4708a02ddbea696a4a5902eb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023782298197102672",
"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/8858352236248570080/+/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": "1610414009347436",
"url": "https://ci.chromium.org/b/8858352236248570080",
"utcnow_ts": "1610414009464309"
}
}
[01:13:29.475] Task URL: https://ci.chromium.org/b/8858352236248570080
[01:13:29.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:2:0) after 1m0s
[01:13:33.442] Received PubSub notification, asking Buildbucket for the build status
[01:13:33.634] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:29.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:2:0)
[01:14:29.551] Timer tick, asking Buildbucket for the build status
[01:14:29.814] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:29.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:4:0) after 1m0s
[01:15:29.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:4:0)
[01:15:29.915] Timer tick, asking Buildbucket for the build status
[01:15:30.026] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:30.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:5:0) after 1m0s
[01:16:30.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:5:0)
[01:16:30.067] Timer tick, asking Buildbucket for the build status
[01:16:30.345] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:30.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:6:0) after 1m0s
[01:17:30.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:6:0)
[01:17:30.402] Timer tick, asking Buildbucket for the build status
[01:17:30.524] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:30.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:7:0) after 1m0s
[01:18:30.562] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:7:0)
[01:18:30.562] Timer tick, asking Buildbucket for the build status
[01:18:30.771] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:30.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:8:0) after 1m0s
[01:19:30.799] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:8:0)
[01:19:30.799] Timer tick, asking Buildbucket for the build status
[01:19:30.921] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:30.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:9:0) after 1m0s
[01:20:30.976] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:9:0)
[01:20:30.976] Timer tick, asking Buildbucket for the build status
[01:20:31.033] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:31.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:10:0) after 1m0s
[01:21:31.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:10:0)
[01:21:31.056] Timer tick, asking Buildbucket for the build status
[01:21:31.166] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:31.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:11:0) after 1m0s
[01:22:31.187] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:11:0)
[01:22:31.187] Timer tick, asking Buildbucket for the build status
[01:22:31.252] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:31.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:12:0) after 1m0s
[01:23:31.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:12:0)
[01:23:31.287] Timer tick, asking Buildbucket for the build status
[01:23:31.617] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:31.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:13:0) after 1m0s
[01:24:31.690] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:13:0)
[01:24:31.690] Timer tick, asking Buildbucket for the build status
[01:24:31.766] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:31.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:14:0) after 1m0s
[01:25:31.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:14:0)
[01:25:31.813] Timer tick, asking Buildbucket for the build status
[01:25:31.912] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:31.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:15:0) after 1m0s
[01:26:31.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:15:0)
[01:26:31.936] Timer tick, asking Buildbucket for the build status
[01:26:32.059] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:32.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:16:0) after 1m0s
[01:27:32.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:16:0)
[01:27:32.087] Timer tick, asking Buildbucket for the build status
[01:27:32.196] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:32.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:17:0) after 1m0s
[01:28:32.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:17:0)
[01:28:32.223] Timer tick, asking Buildbucket for the build status
[01:28:32.327] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:32.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:18:0) after 1m0s
[01:29:32.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:18:0)
[01:29:32.398] Timer tick, asking Buildbucket for the build status
[01:29:32.737] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:32.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:19:0) after 1m0s
[01:30:32.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:19:0)
[01:30:32.774] Timer tick, asking Buildbucket for the build status
[01:30:32.862] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:32.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:20:0) after 1m0s
[01:31:32.884] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:20:0)
[01:31:32.884] Timer tick, asking Buildbucket for the build status
[01:31:33.383] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:33.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:21:0) after 1m0s
[01:32:33.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:21:0)
[01:32:33.403] Timer tick, asking Buildbucket for the build status
[01:32:36.088] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:36.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:22:0) after 1m0s
[01:33:36.096] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:22:0)
[01:33:36.096] Timer tick, asking Buildbucket for the build status
[01:33:36.251] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:36.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:23:0) after 1m0s
[01:34:36.235] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:23:0)
[01:34:36.235] Timer tick, asking Buildbucket for the build status
[01:34:36.374] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:36.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:24:0) after 1m0s
[01:35:36.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:24:0)
[01:35:36.444] Timer tick, asking Buildbucket for the build status
[01:35:36.669] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:36.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:25:0) after 1m0s
[01:36:36.682] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:25:0)
[01:36:36.682] Timer tick, asking Buildbucket for the build status
[01:36:36.849] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:36.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:26:0) after 1m0s
[01:37:36.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:26:0)
[01:37:36.875] Timer tick, asking Buildbucket for the build status
[01:37:37.546] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:37.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:27:0) after 1m0s
[01:38:37.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:27:0)
[01:38:37.633] Timer tick, asking Buildbucket for the build status
[01:38:37.769] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:37.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:28:0) after 1m0s
[01:39:37.796] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:28:0)
[01:39:37.796] Timer tick, asking Buildbucket for the build status
[01:39:37.938] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:37.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:29:0) after 1m0s
[01:40:38.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:29:0)
[01:40:38.053] Timer tick, asking Buildbucket for the build status
[01:40:40.358] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:40.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:30:0) after 1m0s
[01:41:40.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:30:0)
[01:41:40.408] Timer tick, asking Buildbucket for the build status
[01:41:40.490] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:40.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:31:0) after 1m0s
[01:42:40.590] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:31:0)
[01:42:40.590] Timer tick, asking Buildbucket for the build status
[01:42:40.912] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:40.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:32:0) after 1m0s
[01:43:41.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:32:0)
[01:43:41.006] Timer tick, asking Buildbucket for the build status
[01:43:41.138] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:41.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:33:0) after 1m0s
[01:44:41.257] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:33:0)
[01:44:41.257] Timer tick, asking Buildbucket for the build status
[01:44:41.363] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:41.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:34:0) after 1m0s
[01:45:41.423] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:34:0)
[01:45:41.423] Timer tick, asking Buildbucket for the build status
[01:45:47.056] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:47.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:35:0) after 1m0s
[01:46:47.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:35:0)
[01:46:47.135] Timer tick, asking Buildbucket for the build status
[01:46:47.248] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:47.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:36:0) after 1m0s
[01:47:47.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:36:0)
[01:47:47.342] Timer tick, asking Buildbucket for the build status
[01:47:47.421] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:47.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:37:0) after 1m0s
[01:48:47.483] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:37:0)
[01:48:47.483] Timer tick, asking Buildbucket for the build status
[01:48:47.988] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:47.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:38:0) after 1m0s
[01:49:47.987] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:38:0)
[01:49:47.987] Timer tick, asking Buildbucket for the build status
[01:49:48.511] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:48.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:39:0) after 1m0s
[01:50:48.537] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:39:0)
[01:50:48.537] Timer tick, asking Buildbucket for the build status
[01:50:48.646] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:48.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:40:0) after 1m0s
[01:51:48.742] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:40:0)
[01:51:48.742] Timer tick, asking Buildbucket for the build status
[01:51:48.820] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:48.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:41:0) after 1m0s
[01:52:48.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:41:0)
[01:52:48.853] Timer tick, asking Buildbucket for the build status
[01:52:49.122] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:49.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:42:0) after 1m0s
[01:53:49.244] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:42:0)
[01:53:49.244] Timer tick, asking Buildbucket for the build status
[01:53:49.552] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:49.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:43:0) after 1m0s
[01:54:49.614] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:43:0)
[01:54:49.614] Timer tick, asking Buildbucket for the build status
[01:54:49.728] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:49.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:44:0) after 1m0s
[01:55:49.832] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:44:0)
[01:55:49.832] Timer tick, asking Buildbucket for the build status
[01:55:49.984] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:49.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:45:0) after 1m0s
[01:56:50.026] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:45:0)
[01:56:50.026] Timer tick, asking Buildbucket for the build status
[01:56:50.479] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:50.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:46:0) after 1m0s
[01:57:50.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:46:0)
[01:57:50.593] Timer tick, asking Buildbucket for the build status
[01:57:50.698] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:50.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:47:0) after 1m0s
[01:58:50.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:47:0)
[01:58:50.747] Timer tick, asking Buildbucket for the build status
[01:58:50.906] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:50.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:48:0) after 1m0s
[01:59:51.000] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:48:0)
[01:59:51.000] Timer tick, asking Buildbucket for the build status
[01:59:51.092] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:51.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:49:0) after 1m0s
[02:00:51.189] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:49:0)
[02:00:51.189] Timer tick, asking Buildbucket for the build status
[02:00:52.272] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:52.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:50:0) after 1m0s
[02:01:52.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:50:0)
[02:01:52.281] Timer tick, asking Buildbucket for the build status
[02:01:52.508] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:52.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:51:0) after 1m0s
[02:02:52.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:51:0)
[02:02:52.526] Timer tick, asking Buildbucket for the build status
[02:02:52.737] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:52.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:52:0) after 1m0s
[02:03:52.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:52:0)
[02:03:52.753] Timer tick, asking Buildbucket for the build status
[02:03:52.904] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:52.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:53:0) after 1m0s
[02:04:52.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:53:0)
[02:04:52.878] Timer tick, asking Buildbucket for the build status
[02:04:53.346] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:53.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:54:0) after 1m0s
[02:05:53.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:54:0)
[02:05:53.369] Timer tick, asking Buildbucket for the build status
[02:05:53.793] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:53.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:55:0) after 1m0s
[02:06:53.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:55:0)
[02:06:53.837] Timer tick, asking Buildbucket for the build status
[02:06:54.218] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:54.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:56:0) after 1m0s
[02:07:54.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:56:0)
[02:07:54.242] Timer tick, asking Buildbucket for the build status
[02:07:54.631] Build 8858352236248570080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:54.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023782298197102672:57:0) after 1m0s
[02:08:33.363] Received PubSub notification, asking Buildbucket for the build status
[02:08:33.669] Build 8858352236248570080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:08:33.669] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610417311217384",
"created_by": "project:chromium",
"created_ts": "1610414008817874",
"id": "8858352236248570080",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b6de0c06998876af4708a02ddbea696a4a5902eb\"}}",
"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\": \"b6de0c06998876af4708a02ddbea696a4a5902eb\", \"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-ervs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16766, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-1\", \"got_angle_revision\": \"49d291065feeea710cf05c522c815091e1728aad\", \"got_dawn_revision\": \"99c3a691c23dbd75075eb852d2f6a1c569148826\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"b6de0c06998876af4708a02ddbea696a4a5902eb\", \"got_revision_cp\": \"refs/heads/master@{#842298}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"3549479dc4ccd92ef3b9e179080dcec1a430b01d\", \"got_v8_revision\": \"4451f85e3f8949beadaf5e4c1d9f117d54624260\", \"got_v8_revision_cp\": \"refs/heads/8.9.238@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"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\": \"b6de0c06998876af4708a02ddbea696a4a5902eb\", \"swarm_hashes_refs/heads/master(at){#842298}_without_patch\": {\"absl_hardening_tests\": \"39947578cad4b4944d238c2e290f470ecd715e06\", \"accessibility_unittests\": \"a9b0e140007bf904870ed70e493c6ff59e107f2b\", \"angle_unittests\": \"a1c78473aa913b8ad184e584c7613089d4a842a0\", \"app_shell_unittests\": \"049c88101b2ac03c3c9dd781d974125f3eaab4af\", \"aura_unittests\": \"996faeaa3197568926a83397a6c8fa0c043a85c8\", \"base_unittests\": \"8914a67e419804ceb90b1c7ccde6d67d294cc616\", \"base_util_unittests\": \"800ba2cc0e6a277e72c249fe37a7d999f3929c7e\", \"blink_common_unittests\": \"44583b1950d526cb56aab03c60e85a369832ff20\", \"blink_fuzzer_unittests\": \"b23ada04931d99c3c49d5841ad602f20e6e121a3\", \"blink_heap_unittests\": \"6af8af8639afa41cb0791c8fc9a676430adc3c2e\", \"blink_platform_unittests\": \"6e50f1787ef202b1e1ce1048e9dd1e9de4d2f996\", \"blink_unittests\": \"c36c311a8968809cf8ca0176e8d995300302d158\", \"boringssl_crypto_tests\": \"170dbbe5a69c12612507a65ff9eab6a6d9a94e6e\", \"boringssl_ssl_tests\": \"846d68e10ac80200edc8c8161b0f05e14a1cedb5\", \"browser_switcher_bho_unittests\": \"ebba3240b94c1ff09a05e3d559f51d8d76023665\", \"browser_tests\": \"a43a5cd4e3f330cf75b151b6dca67ece07620ce6\", \"capture_unittests\": \"899897ed4ab066018134d3e09e0dec0671f26b23\", \"cast_unittests\": \"31394e1170c5f8293bd9eff8eaa1bc778f4aba83\", \"cc_unittests\": \"9e1dade2d11772221675d70db43ee8ffbd0cb9ea\", \"chrome_app_unittests\": \"37306f8bbd9ecf85740b48c7915ce92c99bde319\", \"chrome_cleaner_unittests\": \"c2dcfccbaefe9f3d4e3149bd0cdaa290f8f32f90\", \"chrome_elf_unittests\": \"c1173ed7b66dd527ed04c7d028be7e05e6d94179\", \"chromedriver_unittests\": \"792672207be0fac20faaaf9975d07abebbbef6df\", \"components_browsertests\": \"b5fee08643fedac4862421b9f5dcb13b8d21a2b3\", \"components_unittests\": \"84de1d3fd215c57e7e5892381b5165da63643dca\", \"compositor_unittests\": \"c9da6807aa5da893769acd6dd97f06f0aa1fea60\", \"content_browsertests\": \"5d93efb3b6ba8e28b69635724ddfe15dd4c3b4d4\", \"content_unittests\": \"0ff7ff386298455d26bc87685a07b5e22bf2f272\", \"courgette_unittests\": \"762ca72eb01e26642a15fac137d2d1da13646abd\", \"crashpad_tests\": \"ab26af0352985d1a4f58c4afb2b8ba2026f2d6ec\", \"cronet_tests\": \"2cc96d238bee53b885f849e9a87b015c087de0bf\", \"cronet_unittests\": \"4ac83239ddb45d79846e04669347722a72dde941\", \"crypto_unittests\": \"a5fca417f6faef9bc3ccaee3d292f3e62a371e55\", \"delayloads_unittests\": \"88761b7ad4a026d27551e177d787e6d541b298e1\", \"device_unittests\": \"067e226a07af0be7fb69f70964f3b67935d1d047\", \"display_unittests\": \"7c08f975bbecfc0847cd9e0e372a7f97a347405b\", \"elevation_service_unittests\": \"80ee391426461876154bba8fcb9891fb03bbad41\", \"events_unittests\": \"4fab12fbbeb57e90745d3b3515b284da8190548d\", \"extensions_browsertests\": \"a1cb76be72a7c54d04577dd304ad825cf57dd4d0\", \"extensions_unittests\": \"888a1df0b222fa95773a3b3df7f2e6592c91d68e\", \"filesystem_service_unittests\": \"5a74b387aa56e57a27f5b86551b67114b3e1b213\", \"gcm_unit_tests\": \"6ac9a1184d1ec5fb146d7e5f60a495fe5b8922eb\", \"gcp_unittests\": \"a5c7b6e1ec4a1f08ea680a6864c5e4e4f41797a9\", \"gfx_unittests\": \"1f2103b0b255546baa9917304e62cded2f460846\", \"gin_unittests\": \"0232a753fbf9d2426a39aee1a7a893bbf864358c\", \"google_apis_unittests\": \"6d29c647dc31db9ce21d1826b7f2b4feea21c4f8\", \"gpu_unittests\": \"903d3c94d33f0278732a8ca63b9ada40cbf674fb\", \"gwp_asan_unittests\": \"b5335895f33b4abb0188adec793609987f65d04b\", \"headless_browsertests\": \"71ebf5f7cc360b9ce5c160ba43a5686ee8c7d97c\", \"headless_unittests\": \"958a81135b5bcbb6f3ca6f9624880b256bc945c7\", \"install_static_unittests\": \"ded0e558355334df9117a47a97a9a9df15f093ac\", \"installer_util_unittests\": \"bbfb33ed09762586b3b659e496d041e2fc4e2d8a\", \"interactive_ui_tests\": \"fd0ae682eefcb154c07baba6fc9f14ac8b91de17\", \"ipc_tests\": \"900cecd401aa003899d153388070f6228088b8a4\", \"jingle_unittests\": \"24c8f3e527d985ba06480643430c4366cac81a77\", \"latency_unittests\": \"8c422f3d16fe61312f4f9d5330212dc5042dda86\", \"libjingle_xmpp_unittests\": \"12afa18fdd72760b1ed60ea527ca717520409ab3\", \"liburlpattern_unittests\": \"75ba19a0dea304bd6eb561e6f0a96c023b8b2cce\", \"media_blink_unittests\": \"97119743e34e333cc385c0438c77f186b7e5ff5c\", \"media_unittests\": \"cfb50d0b78ca521bdeeb2c5210da53cd8aa80f0c\", \"message_center_unittests\": \"f4b1769bbef63f058570462d739d8570730d4ec2\", \"midi_unittests\": \"a0625cfd642dca46cd465b2e6a6c569c896c5a0e\", \"mojo_core_unittests\": \"fa9f3e30eb7f093b0e37f82e20b063d2c535648a\", \"mojo_unittests\": \"155b89af999c4c71e921a46f05dcebbdb93f5338\", \"nacl_loader_unittests\": \"6d3613f90a0a9bcf8d92dd982215501894132fd8\", \"native_theme_unittests\": \"c4a722603f49dbc4da819968bd937465adc32cab\", \"net_unittests\": \"45fc67105b5ba8eafc541ba836193b3fa226ff0f\", \"notification_helper_unittests\": \"ead8c112b5ba36b5f305218d5cc3349c59f883c4\", \"pdf_unittests\": \"0a7a4c5d4f9db036368cf194f66f054155387cb9\", \"perfetto_unittests\": \"d742e30d9bd4c65c866853c91ac11c62feb159f3\", \"ppapi_unittests\": \"d4e45b1b4eba2c1e8b2ababbc21fa708012851e5\", \"printing_unittests\": \"05e6e3ac6f8c1a63bd8e79b340e38c1c14dd156c\", \"remoting_unittests\": \"c7ffb39a8dc4a7522d6fa8db4faf787c27b78750\", \"sbox_integration_tests\": \"af187132fcc3e20595faa3ffd11695ff956baa5a\", \"sbox_unittests\": \"fdc8c01dae39594e6d62e1ebeff3ca88215207e0\", \"sbox_validation_tests\": \"c68bb41cf5722446eaf3229b3283b967ae6e7a82\", \"service_manager_unittests\": \"b5cbb4fdd01f5a0f1022d773e52e3f3cb8df5835\", \"services_unittests\": \"e162e3a59b36ec590465c4106874c9927aa5bb97\", \"setup_unittests\": \"5013ac23e6ec1f48f7666eabe93d481f5496134b\", \"shell_dialogs_unittests\": \"aa0e3128c7628554cb0a3d4780db0d8af545528a\", \"skia_unittests\": \"8538ed10023ad166e1cddfb22799c629b691d89f\", \"snapshot_unittests\": \"81f8b8d1e11db76a11e5558519d8804af0643453\", \"sql_unittests\": \"574b2fae6b73b55f822c7ba09b50ee3cf35565db\", \"storage_unittests\": \"161c508a091f29a589054aee4738058f2826c746\", \"sync_integration_tests\": \"0f2ec21c0cf2a8ee80605317c9e3fdc6fd1a91cd\", \"traffic_annotation_auditor_unittests\": \"5865137ab453f50d5d7d06db2196677d1172ea5a\", \"ui_base_unittests\": \"5cf8e9b54f14eee6512208086bcd366b4ea2ed5f\", \"ui_touch_selection_unittests\": \"4b406058af88101bb5fd9786b849084081d64078\", \"unit_tests\": \"b627d127df88534eca908443f1d38422d76cce00\", \"updater_tests\": \"10a4cf312ea14f301a9d87cb56bb116ac3f4b9e9\", \"url_unittests\": \"a3db5e1c977b1b260e8e7f699cc306f16568341c\", \"views_unittests\": \"57711342dce1f6b4e80e6122d9477c28da86c0fd\", \"viz_unittests\": \"8a68caf83006e093011bd0ee2720b6d8096411e4\", \"vr_common_unittests\": \"8193469b29fe19420ca8aac0aab7617944c502c4\", \"vr_pixeltests\": \"f38f6f166ce2a9cf3978db4e02a7170dea4e0d08\", \"weblayer_browsertests\": \"b5203882b9f02d6c54395deff5c710a1b273e83b\", \"weblayer_unittests\": \"d50ed79cd98389e99de750e8ad8cd87bf45a56be\", \"wm_unittests\": \"cfb669477adcb8d251f4a33286735a536a4875cc\", \"wtf_unittests\": \"68c2eabab38458b21fba7faba4088fce2c7e6286\", \"zlib_unittests\": \"d327ec5ddfe03de3724d7af6cbca38cb5bcad0de\", \"zucchini_unittests\": \"5b4a35d76a5156d73f0269d42d294a2eb211fcfd\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-ervs\"], \"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": "1610414012754173",
"status": "COMPLETED",
"status_changed_ts": "1610417311727600",
"tags": [
"build_address:luci.chromium.ci/win-asan/16766",
"builder:win-asan",
"buildset:commit/git/b6de0c06998876af4708a02ddbea696a4a5902eb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b6de0c06998876af4708a02ddbea696a4a5902eb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023782298197102672",
"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/8858352236248570080/+/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:510cf9369ccae410",
"user_agent:luci-scheduler"
],
"updated_ts": "1610417311756029",
"url": "https://ci.chromium.org/b/8858352236248570080",
"utcnow_ts": "1610417313658343"
}
}
[02:08:33.669] Invocation finished in 55m6.092666595s with status SUCCEEDED