[11:17:32.294] New invocation is queued and will start shortly
[11:17:33.426] Starting the invocation (attempt 1)
[11:17:33.461] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:17:33.461] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:17:33.462] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027911753327539728",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bd7af89f976639bd7f5af053f4c490ed6c002269\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027911753327539728",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/bd7af89f976639bd7f5af053f4c490ed6c002269",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd7af89f976639bd7f5af053f4c490ed6c002269",
"gitiles_ref:refs/heads/master"
]
}
[11:17:34.053] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606475853550331",
"id": "8862481691345868800",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd7af89f976639bd7f5af053f4c490ed6c002269\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606475853861404",
"tags": [
"build_address:luci.chromium.ci/win-asan/15883",
"builder:win-asan",
"buildset:commit/git/bd7af89f976639bd7f5af053f4c490ed6c002269",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd7af89f976639bd7f5af053f4c490ed6c002269",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027911753327539728",
"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/8862481691345868800/+/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": "1606475853861875",
"url": "https://ci.chromium.org/b/8862481691345868800",
"utcnow_ts": "1606475854044651"
}
}
[11:17:34.053] Task URL: https://ci.chromium.org/b/8862481691345868800
[11:17:34.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:2:0) after 1m0s
[11:17:36.411] Received PubSub notification, asking Buildbucket for the build status
[11:17:36.492] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:34.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:2:0)
[11:18:34.122] Timer tick, asking Buildbucket for the build status
[11:18:34.280] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:34.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:4:0) after 1m0s
[11:19:34.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:4:0)
[11:19:34.304] Timer tick, asking Buildbucket for the build status
[11:19:34.910] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:34.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:5:0) after 1m0s
[11:20:34.969] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:5:0)
[11:20:34.969] Timer tick, asking Buildbucket for the build status
[11:20:35.099] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:35.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:6:0) after 1m0s
[11:21:35.204] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:6:0)
[11:21:35.204] Timer tick, asking Buildbucket for the build status
[11:21:35.394] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:35.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:7:0) after 1m0s
[11:22:35.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:7:0)
[11:22:35.529] Timer tick, asking Buildbucket for the build status
[11:22:35.752] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:35.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:8:0) after 1m0s
[11:23:35.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:8:0)
[11:23:35.831] Timer tick, asking Buildbucket for the build status
[11:23:36.026] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:36.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:9:0) after 1m0s
[11:24:36.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:9:0)
[11:24:36.085] Timer tick, asking Buildbucket for the build status
[11:24:36.143] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:36.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:10:0) after 1m0s
[11:25:36.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:10:0)
[11:25:36.327] Timer tick, asking Buildbucket for the build status
[11:25:36.476] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:36.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:11:0) after 1m0s
[11:26:36.649] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:11:0)
[11:26:36.649] Timer tick, asking Buildbucket for the build status
[11:26:36.736] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:36.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:12:0) after 1m0s
[11:27:36.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:12:0)
[11:27:36.831] Timer tick, asking Buildbucket for the build status
[11:27:37.184] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:37.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:13:0) after 1m0s
[11:28:37.273] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:13:0)
[11:28:37.273] Timer tick, asking Buildbucket for the build status
[11:28:37.391] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:37.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:14:0) after 1m0s
[11:29:37.426] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:14:0)
[11:29:37.426] Timer tick, asking Buildbucket for the build status
[11:29:37.541] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:37.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:15:0) after 1m0s
[11:30:37.754] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:15:0)
[11:30:37.754] Timer tick, asking Buildbucket for the build status
[11:30:39.016] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:39.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:16:0) after 1m0s
[11:31:39.194] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:16:0)
[11:31:39.194] Timer tick, asking Buildbucket for the build status
[11:31:39.342] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:39.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:17:0) after 1m0s
[11:32:39.349] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:17:0)
[11:32:39.349] Timer tick, asking Buildbucket for the build status
[11:32:39.472] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:39.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:18:0) after 1m0s
[11:33:39.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:18:0)
[11:33:39.528] Timer tick, asking Buildbucket for the build status
[11:33:39.817] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:39.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:19:0) after 1m0s
[11:34:39.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:19:0)
[11:34:39.874] Timer tick, asking Buildbucket for the build status
[11:34:40.257] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:40.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:20:0) after 1m0s
[11:35:40.368] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:20:0)
[11:35:40.368] Timer tick, asking Buildbucket for the build status
[11:35:40.588] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:40.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:21:0) after 1m0s
[11:36:40.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:21:0)
[11:36:40.636] Timer tick, asking Buildbucket for the build status
[11:36:40.810] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:40.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:22:0) after 1m0s
[11:37:40.830] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:22:0)
[11:37:40.830] Timer tick, asking Buildbucket for the build status
[11:37:41.435] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:41.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:23:0) after 1m0s
[11:38:41.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:23:0)
[11:38:41.481] Timer tick, asking Buildbucket for the build status
[11:38:41.605] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:41.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:24:0) after 1m0s
[11:39:41.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:24:0)
[11:39:41.657] Timer tick, asking Buildbucket for the build status
[11:39:41.842] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:41.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:25:0) after 1m0s
[11:40:41.908] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:25:0)
[11:40:41.908] Timer tick, asking Buildbucket for the build status
[11:40:42.092] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:42.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:26:0) after 1m0s
[11:41:42.254] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:26:0)
[11:41:42.254] Timer tick, asking Buildbucket for the build status
[11:41:42.595] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:42.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:27:0) after 1m0s
[11:42:42.696] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:27:0)
[11:42:42.696] Timer tick, asking Buildbucket for the build status
[11:42:42.809] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:42.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:28:0) after 1m0s
[11:43:42.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:28:0)
[11:43:42.898] Timer tick, asking Buildbucket for the build status
[11:43:43.048] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:43.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:29:0) after 1m0s
[11:44:43.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:29:0)
[11:44:43.079] Timer tick, asking Buildbucket for the build status
[11:44:43.165] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:43.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:30:0) after 1m0s
[11:45:43.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:30:0)
[11:45:43.227] Timer tick, asking Buildbucket for the build status
[11:45:43.661] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:43.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:31:0) after 1m0s
[11:46:43.735] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:31:0)
[11:46:43.735] Timer tick, asking Buildbucket for the build status
[11:46:43.837] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:43.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:32:0) after 1m0s
[11:47:43.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:32:0)
[11:47:43.888] Timer tick, asking Buildbucket for the build status
[11:47:44.043] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:44.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:33:0) after 1m0s
[11:48:44.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:33:0)
[11:48:44.097] Timer tick, asking Buildbucket for the build status
[11:48:44.226] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:44.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:34:0) after 1m0s
[11:49:44.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:34:0)
[11:49:44.247] Timer tick, asking Buildbucket for the build status
[11:49:44.359] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:44.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:35:0) after 1m0s
[11:50:44.345] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:35:0)
[11:50:44.345] Timer tick, asking Buildbucket for the build status
[11:50:44.538] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:44.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:36:0) after 1m0s
[11:51:44.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:36:0)
[11:51:44.561] Timer tick, asking Buildbucket for the build status
[11:51:44.678] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:44.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:37:0) after 1m0s
[11:52:44.653] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:37:0)
[11:52:44.653] Timer tick, asking Buildbucket for the build status
[11:52:45.007] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:45.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:38:0) after 1m0s
[11:53:45.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:38:0)
[11:53:45.056] Timer tick, asking Buildbucket for the build status
[11:53:45.236] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:45.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:39:0) after 1m0s
[11:54:45.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:39:0)
[11:54:45.226] Timer tick, asking Buildbucket for the build status
[11:54:45.352] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:45.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:40:0) after 1m0s
[11:55:45.404] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:40:0)
[11:55:45.404] Timer tick, asking Buildbucket for the build status
[11:55:45.512] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:45.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:41:0) after 1m0s
[11:56:45.581] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:41:0)
[11:56:45.581] Timer tick, asking Buildbucket for the build status
[11:56:45.834] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:45.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:42:0) after 1m0s
[11:57:45.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:42:0)
[11:57:45.899] Timer tick, asking Buildbucket for the build status
[11:57:46.006] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:46.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:43:0) after 1m0s
[11:58:46.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:43:0)
[11:58:46.039] Timer tick, asking Buildbucket for the build status
[11:58:46.245] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:46.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:44:0) after 1m0s
[11:59:46.299] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:44:0)
[11:59:46.299] Timer tick, asking Buildbucket for the build status
[11:59:46.451] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:46.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:45:0) after 1m0s
[12:00:46.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:45:0)
[12:00:46.535] Timer tick, asking Buildbucket for the build status
[12:00:46.632] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:46.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:46:0) after 1m0s
[12:01:46.644] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:46:0)
[12:01:46.644] Timer tick, asking Buildbucket for the build status
[12:01:46.720] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:46.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:47:0) after 1m0s
[12:02:46.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:47:0)
[12:02:46.777] Timer tick, asking Buildbucket for the build status
[12:02:47.007] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:47.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:48:0) after 1m0s
[12:03:47.064] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:48:0)
[12:03:47.064] Timer tick, asking Buildbucket for the build status
[12:03:47.220] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:47.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:49:0) after 1m0s
[12:04:47.280] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:49:0)
[12:04:47.280] Timer tick, asking Buildbucket for the build status
[12:04:47.615] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:47.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:50:0) after 1m0s
[12:05:47.637] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:50:0)
[12:05:47.637] Timer tick, asking Buildbucket for the build status
[12:05:47.777] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:47.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:51:0) after 1m0s
[12:06:47.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:51:0)
[12:06:47.804] Timer tick, asking Buildbucket for the build status
[12:06:47.889] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:47.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:52:0) after 1m0s
[12:07:47.915] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:52:0)
[12:07:47.915] Timer tick, asking Buildbucket for the build status
[12:07:48.043] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:48.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:53:0) after 1m0s
[12:08:48.072] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:53:0)
[12:08:48.072] Timer tick, asking Buildbucket for the build status
[12:08:48.263] Build 8862481691345868800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:48.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027911753327539728:54:0) after 1m0s
[12:08:52.770] Received PubSub notification, asking Buildbucket for the build status
[12:08:53.755] Build 8862481691345868800: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:08:53.755] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606478932094040",
"created_by": "project:chromium",
"created_ts": "1606475853550331",
"id": "8862481691345868800",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd7af89f976639bd7f5af053f4c490ed6c002269\"}}",
"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\": \"bd7af89f976639bd7f5af053f4c490ed6c002269\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-4-qhsy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15883, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"96b71bee13a9281e303311e46711dbd30e9046ed\", \"got_dawn_revision\": \"4814bdbdeae40186a61dfb7494390e64820daa4f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"bd7af89f976639bd7f5af053f4c490ed6c002269\", \"got_revision_cp\": \"refs/heads/master@{#831525}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"961f93287f84e7e7a7f5ff8a43c7adf14ca7fc42\", \"got_v8_revision_cp\": \"refs/heads/8.9.63@{#1}\", \"got_webrtc_revision\": \"0d863f72a8c747c1b41f2798e5201e1abcdaec2b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32704}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd7af89f976639bd7f5af053f4c490ed6c002269\", \"swarm_hashes_refs/heads/master(at){#831525}_without_patch\": {\"absl_hardening_tests\": \"82aa67fbb5885bc90653b5daa2d0c7c71f6c2dba\", \"accessibility_unittests\": \"209520b4c91bb6cb33949e34e38b6ef27dbd72d7\", \"angle_unittests\": \"f54b4404a4d4a9d7d2b9c08982caca36f73c773a\", \"app_shell_unittests\": \"12a00c1bf6bb18e8ad9831bfaeac06b35975192f\", \"aura_unittests\": \"695db68dd54fee4cc50558b0911ca1ab6ec12f49\", \"base_unittests\": \"849c5a28d75a0f137608467f4f6b8db9218126b0\", \"base_util_unittests\": \"22dae98eec4f8488849be3196607efa28f5e429e\", \"blink_common_unittests\": \"cbb27c5748e4706188c5d0c555df63942d83cd6f\", \"blink_fuzzer_unittests\": \"1567e830e3cbdc7cc141f2beb821874e3c2d5d27\", \"blink_heap_unittests\": \"18b7ec30f323679af9ceae62aef24eefe3beae97\", \"blink_platform_unittests\": \"c0832384990bc8bdb8475d330d00bc2199aeca94\", \"blink_unittests\": \"a7c1a6df67bb64aeb21ad0191ef1da1d3853369c\", \"boringssl_crypto_tests\": \"70879457f1fc7b8ba0f90aabe885b4877537f0c8\", \"boringssl_ssl_tests\": \"74d4cfac1c832b14ffe6dd5695a476b5a4421b09\", \"browser_switcher_bho_unittests\": \"af49d9ab209cf4b3b436608eb48c48acd746b828\", \"browser_tests\": \"757cb2e38815479c66bf320e3ab711ff597705a7\", \"capture_unittests\": \"afb0f24335021e20a4ec521efa2b2e1de8364f97\", \"cast_unittests\": \"09c77a25dbd1bdf87ee62cb328c64adcdf25849f\", \"cc_unittests\": \"d3942bb9ad14d987318aaabc72e8e185448fb692\", \"chrome_app_unittests\": \"d8c7302f2693cbba21a7403f592f4894a2eddb95\", \"chrome_cleaner_unittests\": \"2b1ea2abbb39cbf01951355cb25a46458e9e3025\", \"chrome_elf_unittests\": \"7836cdecc99425cf9f0fef7a12d72aabf454a22c\", \"chromedriver_unittests\": \"b88d4393a8c9014ea27bbaf03cac98beda1cbb2c\", \"components_browsertests\": \"1aa67d0fb45c5b2b6a153564588f4da24579267e\", \"components_unittests\": \"afb206720946de479dae25cf950cb26e100c9fbb\", \"compositor_unittests\": \"ec9cc78f7bf51663fd067d4ca74911c7a610811c\", \"content_browsertests\": \"9e4519ca314c858b18044172633efc6b107c2f62\", \"content_unittests\": \"51435ef19ea2c0edee2b01701afe2ec99da7aeb1\", \"courgette_unittests\": \"73e4c0e4357ffe6f9c0bda3b1aa8053c4a350d1e\", \"crashpad_tests\": \"730d05a025601d65d9be64c43a90dd56b9896ff9\", \"cronet_tests\": \"7fe1b131bec5e6eb993bd8f87a319cc8adab371e\", \"cronet_unittests\": \"9915e97f2921a29ace934f157fe2434c7db78daf\", \"crypto_unittests\": \"1542c0096b5a673dafa8cdbdde8605ab40d8c7b6\", \"delayloads_unittests\": \"1eca47711fed913b77fdf248d0f7885a4b518533\", \"device_unittests\": \"ad1c6f393b159890834930b146a572e39b711750\", \"display_unittests\": \"e212d2d83d2e048df32540d69a35fe967c23f16d\", \"elevation_service_unittests\": \"474bbc0ab534f04fa218a3c6969e062467e571d2\", \"events_unittests\": \"557d28ac3ab9d198b4e7495a61f234654b412a55\", \"extensions_browsertests\": \"f48d872203f919e9f4208d5bd3b0a2052d1adc3e\", \"extensions_unittests\": \"ccfd16cf2bac87eb2528a0b241e2ad1e57acf494\", \"filesystem_service_unittests\": \"2b9d6174380df17284c3b6097638632de7184cfe\", \"gcm_unit_tests\": \"3355efb20189e3972db3c4315037c2593139fef6\", \"gcp_unittests\": \"63efb5d3322e7e88293259abc3f61f425824485e\", \"gfx_unittests\": \"20f233fc4dc7e5fa41b41e1d514c52487e86067a\", \"gin_unittests\": \"ea193d6d53370394c007fe60f2119969cf1c6f8d\", \"google_apis_unittests\": \"4fe52cda3dd0e8a8afc2a58a410d515494a29c86\", \"gpu_unittests\": \"19c50cab3ebab16ed72eba7d59ae8d4df8943f10\", \"gwp_asan_unittests\": \"fb9e8672dd9392410d8f62def0ac7de9cbe49b04\", \"headless_browsertests\": \"6fd0ce848af775b01584407af1db9e108681c71d\", \"headless_unittests\": \"1282529beb42ab527a5e405cece9fb3f5c242b29\", \"install_static_unittests\": \"c5eeb68b34873c43bc8bbf57ddd1b19a4bb4960e\", \"installer_util_unittests\": \"6e1edef9187151a11972da2f04217da3aba35569\", \"interactive_ui_tests\": \"eda43765c8ece3e226bae3e8812eb4e3cfa30e78\", \"ipc_tests\": \"d03d6ab83a72a59c5c25227c60f6ecf71128d17d\", \"jingle_unittests\": \"941cb9be449f51e4abadf90fa79ec197909f70bc\", \"latency_unittests\": \"0f2c11751c53ea8815a7f052cb9c2947e14a3437\", \"libjingle_xmpp_unittests\": \"c01e4e51af2611a8081f973e0ba2f1c42a936c71\", \"liburlpattern_unittests\": \"fd05ee5b31addaf5047a0e010bb9f6a5a3b1f3d0\", \"media_blink_unittests\": \"a83d82f1c6acff6bb73ad9871ee549668a3bbc6c\", \"media_unittests\": \"ee3bb73f64093229a64b5feed29b13e0c8bb398e\", \"message_center_unittests\": \"8018ed9394f86d51570907f20149f178f1e0e415\", \"midi_unittests\": \"426849819e62b467ba935f7b7b40f4fd5a570f51\", \"mojo_core_unittests\": \"5cd7d119197acac3bc5028d8c948ade749d80ab3\", \"mojo_unittests\": \"448b09146a0516ea8a816e48bbbee6526d62647d\", \"nacl_loader_unittests\": \"6e71a8ed4907d427e288e5ef5ca0001996c78f9c\", \"native_theme_unittests\": \"e0ef5dff2e34e8beab80c20a1aa93d077d60088e\", \"net_unittests\": \"5455e1094c834abe756d6aea029b9dd3d56df418\", \"notification_helper_unittests\": \"06aa92d69d9901b1e5aed67d9668d0313e3c5824\", \"pdf_unittests\": \"4599c5f1766c5ff0b7b9c2dced632a8dd2306f8d\", \"perfetto_unittests\": \"f7bed5bba44cdf165d662b7e0342643e9cd3d2f5\", \"ppapi_unittests\": \"df69aecb2c0776d2899984e0cdd95343d93b4389\", \"printing_unittests\": \"0617a550ce3180f0561c3f5d2989fd575bafe1e7\", \"remoting_unittests\": \"641849c1e233e8e938b2ec388288156971b861fb\", \"sbox_integration_tests\": \"0823695b4ba828c8c3dcf040649143cd5ee72128\", \"sbox_unittests\": \"d25055c36e66b930aa4d72e0df5e1f84b37a68c9\", \"sbox_validation_tests\": \"a00ad8915b9b94bc6871d3347749ea8accaeb5b0\", \"service_manager_unittests\": \"e0d482ab9735fa20ee474e8d918a90b9d379c3d8\", \"services_unittests\": \"6cdf47e20a6bd32582e87b07afe78a1db4920fab\", \"setup_unittests\": \"59411fb1886a1e35218252eee7dd1b65d1e7f3cd\", \"shell_dialogs_unittests\": \"7f7c22f49bbdf4f37ca9e616766a2132fd260403\", \"skia_unittests\": \"29f1156f0770ea92fad7a9492b23dca5b58b23bd\", \"snapshot_unittests\": \"aa9251e19ad1f90edabda5a97cf0d33a9e8e6eaf\", \"sql_unittests\": \"190498fc256713750ba125c38236710735059915\", \"storage_unittests\": \"501ef4e611c17b0f42660e3650f9db40100d0aff\", \"sync_integration_tests\": \"0a0b2e17d3e6649387ec2d3de4a3f7e71c9e543e\", \"traffic_annotation_auditor_unittests\": \"a751bf21a7ac72ffb81ddb3f72ee3a8378f44cba\", \"ui_base_unittests\": \"d9173e7cc1ff28912398e46caf54525ce8047701\", \"ui_touch_selection_unittests\": \"b06bdce1c4de970d63e4ffc82a4294ada4f49302\", \"unit_tests\": \"020900ec5a743db7787b9fefaad783e9cf2b2e14\", \"updater_tests\": \"2f319cd4093c5f34f8319d300dfc6dd408161b88\", \"url_unittests\": \"eea1aba62a0a470fe61554f4564fabf9ee541bc3\", \"views_unittests\": \"3a5a485db9b054cabda37793d99f6297329500aa\", \"viz_unittests\": \"592ff8d88f5bcc86777a487c4d49728c7b77e428\", \"vr_common_unittests\": \"c077139c6c10b8434018d9ecbcf4f61bf850bc53\", \"vr_pixeltests\": \"05a7f422f38f909d8ff259d2c4e3ee8a5ec44db8\", \"weblayer_browsertests\": \"040f3727bde8ac5d3d7d77c6da56153a6c479a8b\", \"weblayer_unittests\": \"42234e3dd289da529f3ee0f4e4e66a2db5215622\", \"wm_unittests\": \"694af65f93ae6b963bebaf22b05d85e6c7632beb\", \"wtf_unittests\": \"f972a90f7ba206b33188ce474657da453778f58c\", \"zlib_unittests\": \"827cd81e434ea291b3382deacf14a071d3870896\", \"zucchini_unittests\": \"5fc74bbf6409902855f80c97fb4a1f73fc22a570\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_64c7a62a02e0da5ef76200bb7658267e40edf0984fe7c0f995e5999242969052_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-4-qhsy\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606475855365224",
"status": "COMPLETED",
"status_changed_ts": "1606478932408589",
"tags": [
"build_address:luci.chromium.ci/win-asan/15883",
"builder:win-asan",
"buildset:commit/git/bd7af89f976639bd7f5af053f4c490ed6c002269",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd7af89f976639bd7f5af053f4c490ed6c002269",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027911753327539728",
"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/8862481691345868800/+/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:50223dbb528f0f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606478932413342",
"url": "https://ci.chromium.org/b/8862481691345868800",
"utcnow_ts": "1606478933713848"
}
}
[12:08:53.755] Invocation finished in 51m21.478018027s with status SUCCEEDED