[12:44:04.426] New invocation is queued and will start shortly
[12:44:05.564] Starting the invocation (attempt 1)
[12:44:05.602] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:44:05.602] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:44:05.602] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023104669774449504",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"23e85cf80993ee7b6301b12be9277a9bc1edd468\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023104669774449504",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/23e85cf80993ee7b6301b12be9277a9bc1edd468",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/23e85cf80993ee7b6301b12be9277a9bc1edd468",
"gitiles_ref:refs/heads/master"
]
}
[12:44:07.605] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611060245796938",
"id": "8857674607662030064",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"23e85cf80993ee7b6301b12be9277a9bc1edd468\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611060247324192",
"tags": [
"build_address:luci.chromium.ci/win-asan/16892",
"builder:win-asan",
"buildset:commit/git/23e85cf80993ee7b6301b12be9277a9bc1edd468",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/23e85cf80993ee7b6301b12be9277a9bc1edd468",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023104669774449504",
"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/8857674607662030064/+/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": "1611060247324875",
"url": "https://ci.chromium.org/b/8857674607662030064",
"utcnow_ts": "1611060247586806"
}
}
[12:44:07.606] Task URL: https://ci.chromium.org/b/8857674607662030064
[12:44:07.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:2:0) after 1m0s
[12:44:10.760] Received PubSub notification, asking Buildbucket for the build status
[12:44:10.996] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:07.601] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:2:0)
[12:45:07.601] Timer tick, asking Buildbucket for the build status
[12:45:07.906] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:07.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:4:0) after 1m0s
[12:46:07.919] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:4:0)
[12:46:07.919] Timer tick, asking Buildbucket for the build status
[12:46:08.493] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:08.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:5:0) after 1m0s
[12:47:08.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:5:0)
[12:47:08.657] Timer tick, asking Buildbucket for the build status
[12:47:08.895] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:08.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:6:0) after 1m0s
[12:48:09.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:6:0)
[12:48:09.057] Timer tick, asking Buildbucket for the build status
[12:48:09.406] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:09.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:7:0) after 1m0s
[12:49:09.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:7:0)
[12:49:09.576] Timer tick, asking Buildbucket for the build status
[12:49:09.782] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:09.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:8:0) after 1m0s
[12:50:09.889] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:8:0)
[12:50:09.889] Timer tick, asking Buildbucket for the build status
[12:50:09.948] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:09.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:9:0) after 1m0s
[12:51:10.038] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:9:0)
[12:51:10.038] Timer tick, asking Buildbucket for the build status
[12:51:10.181] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:10.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:10:0) after 1m0s
[12:52:10.198] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:10:0)
[12:52:10.198] Timer tick, asking Buildbucket for the build status
[12:52:10.317] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:10.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:11:0) after 1m0s
[12:53:10.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:11:0)
[12:53:10.455] Timer tick, asking Buildbucket for the build status
[12:53:10.519] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:10.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:12:0) after 1m0s
[12:54:10.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:12:0)
[12:54:10.592] Timer tick, asking Buildbucket for the build status
[12:54:10.768] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:10.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:13:0) after 1m0s
[12:55:10.807] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:13:0)
[12:55:10.807] Timer tick, asking Buildbucket for the build status
[12:55:10.929] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:10.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:14:0) after 1m0s
[12:56:11.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:14:0)
[12:56:11.668] Timer tick, asking Buildbucket for the build status
[12:56:11.796] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:11.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:15:0) after 1m0s
[12:57:11.852] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:15:0)
[12:57:11.852] Timer tick, asking Buildbucket for the build status
[12:57:11.911] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:11.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:16:0) after 1m0s
[12:58:12.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:16:0)
[12:58:12.057] Timer tick, asking Buildbucket for the build status
[12:58:12.232] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:12.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:17:0) after 1m0s
[12:59:12.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:17:0)
[12:59:12.321] Timer tick, asking Buildbucket for the build status
[12:59:12.478] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:12.478] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:18:0) after 1m0s
[13:00:12.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:18:0)
[13:00:12.641] Timer tick, asking Buildbucket for the build status
[13:00:12.857] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:12.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:19:0) after 1m0s
[13:01:12.881] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:19:0)
[13:01:12.881] Timer tick, asking Buildbucket for the build status
[13:01:13.018] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:13.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:20:0) after 1m0s
[13:02:13.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:20:0)
[13:02:13.069] Timer tick, asking Buildbucket for the build status
[13:02:13.174] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:13.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:21:0) after 1m0s
[13:03:13.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:21:0)
[13:03:13.371] Timer tick, asking Buildbucket for the build status
[13:03:13.558] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:13.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:22:0) after 1m0s
[13:04:13.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:22:0)
[13:04:13.646] Timer tick, asking Buildbucket for the build status
[13:04:13.765] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:13.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:23:0) after 1m0s
[13:05:13.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:23:0)
[13:05:13.804] Timer tick, asking Buildbucket for the build status
[13:05:13.970] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:13.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:24:0) after 1m0s
[13:06:14.040] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:24:0)
[13:06:14.040] Timer tick, asking Buildbucket for the build status
[13:06:14.312] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:14.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:25:0) after 1m0s
[13:07:14.423] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:25:0)
[13:07:14.423] Timer tick, asking Buildbucket for the build status
[13:07:14.785] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:14.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:26:0) after 1m0s
[13:08:14.822] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:26:0)
[13:08:14.823] Timer tick, asking Buildbucket for the build status
[13:08:15.473] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:15.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:27:0) after 1m0s
[13:09:15.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:27:0)
[13:09:15.569] Timer tick, asking Buildbucket for the build status
[13:09:15.699] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:15.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:28:0) after 1m0s
[13:10:15.744] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:28:0)
[13:10:15.744] Timer tick, asking Buildbucket for the build status
[13:10:15.817] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:15.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:29:0) after 1m0s
[13:11:15.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:29:0)
[13:11:15.896] Timer tick, asking Buildbucket for the build status
[13:11:16.116] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:16.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:30:0) after 1m0s
[13:12:16.136] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:30:0)
[13:12:16.136] Timer tick, asking Buildbucket for the build status
[13:12:16.209] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:16.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:31:0) after 1m0s
[13:13:16.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:31:0)
[13:13:16.228] Timer tick, asking Buildbucket for the build status
[13:13:16.303] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:16.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:32:0) after 1m0s
[13:14:16.310] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:32:0)
[13:14:16.310] Timer tick, asking Buildbucket for the build status
[13:14:16.433] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:16.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:33:0) after 1m0s
[13:15:16.437] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:33:0)
[13:15:16.437] Timer tick, asking Buildbucket for the build status
[13:15:16.770] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:16.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:34:0) after 1m0s
[13:16:16.828] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:34:0)
[13:16:16.828] Timer tick, asking Buildbucket for the build status
[13:16:16.977] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:16.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:35:0) after 1m0s
[13:17:17.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:35:0)
[13:17:17.087] Timer tick, asking Buildbucket for the build status
[13:17:17.209] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:17.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:36:0) after 1m0s
[13:18:17.233] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:36:0)
[13:18:17.233] Timer tick, asking Buildbucket for the build status
[13:18:18.100] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:18.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:37:0) after 1m0s
[13:19:18.185] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:37:0)
[13:19:18.185] Timer tick, asking Buildbucket for the build status
[13:19:18.313] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:18.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:38:0) after 1m0s
[13:20:18.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:38:0)
[13:20:18.333] Timer tick, asking Buildbucket for the build status
[13:20:18.459] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:18.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:39:0) after 1m0s
[13:21:18.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:39:0)
[13:21:18.495] Timer tick, asking Buildbucket for the build status
[13:21:18.594] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:18.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:40:0) after 1m0s
[13:22:18.805] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:40:0)
[13:22:18.805] Timer tick, asking Buildbucket for the build status
[13:22:18.921] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:18.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:41:0) after 1m0s
[13:23:18.993] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:41:0)
[13:23:18.993] Timer tick, asking Buildbucket for the build status
[13:23:19.128] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:19.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:42:0) after 1m0s
[13:24:19.250] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:42:0)
[13:24:19.250] Timer tick, asking Buildbucket for the build status
[13:24:19.666] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:19.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:43:0) after 1m0s
[13:25:19.733] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:43:0)
[13:25:19.733] Timer tick, asking Buildbucket for the build status
[13:25:20.063] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:20.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:44:0) after 1m0s
[13:26:20.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:44:0)
[13:26:20.133] Timer tick, asking Buildbucket for the build status
[13:26:20.262] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:20.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:45:0) after 1m0s
[13:27:20.271] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:45:0)
[13:27:20.272] Timer tick, asking Buildbucket for the build status
[13:27:20.756] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:20.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:46:0) after 1m0s
[13:28:20.795] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:46:0)
[13:28:20.795] Timer tick, asking Buildbucket for the build status
[13:28:20.923] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:20.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:47:0) after 1m0s
[13:29:20.993] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:47:0)
[13:29:20.993] Timer tick, asking Buildbucket for the build status
[13:29:21.297] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:21.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:48:0) after 1m0s
[13:30:21.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:48:0)
[13:30:21.305] Timer tick, asking Buildbucket for the build status
[13:30:21.494] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:21.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:49:0) after 1m0s
[13:31:21.521] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:49:0)
[13:31:21.521] Timer tick, asking Buildbucket for the build status
[13:31:21.922] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:21.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:50:0) after 1m0s
[13:32:21.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:50:0)
[13:32:21.924] Timer tick, asking Buildbucket for the build status
[13:32:22.035] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:22.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:51:0) after 1m0s
[13:33:22.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:51:0)
[13:33:22.035] Timer tick, asking Buildbucket for the build status
[13:33:22.126] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:22.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:52:0) after 1m0s
[13:34:22.171] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:52:0)
[13:34:22.171] Timer tick, asking Buildbucket for the build status
[13:34:22.298] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:22.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:53:0) after 1m0s
[13:35:22.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:53:0)
[13:35:22.323] Timer tick, asking Buildbucket for the build status
[13:35:22.438] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:22.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:54:0) after 1m0s
[13:36:22.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:54:0)
[13:36:22.527] Timer tick, asking Buildbucket for the build status
[13:36:22.619] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:22.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:55:0) after 1m0s
[13:37:22.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:55:0)
[13:37:22.684] Timer tick, asking Buildbucket for the build status
[13:37:22.763] Build 8857674607662030064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:22.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023104669774449504:56:0) after 1m0s
[13:38:13.063] Received PubSub notification, asking Buildbucket for the build status
[13:38:13.159] Build 8857674607662030064: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:38:13.159] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611063491821477",
"created_by": "project:chromium",
"created_ts": "1611060245796938",
"failure_reason": "BUILD_FAILURE",
"id": "8857674607662030064",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"23e85cf80993ee7b6301b12be9277a9bc1edd468\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ECKIncognitoEncryptedMediaTest.FileIO\"}, \"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\": \"23e85cf80993ee7b6301b12be9277a9bc1edd468\", \"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-0-nszv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16892, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-2\", \"got_angle_revision\": \"b69f54069cbf700a4646817805ca77c0d2a01292\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"23e85cf80993ee7b6301b12be9277a9bc1edd468\", \"got_revision_cp\": \"refs/heads/master@{#844742}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"8da0f82baf359e2b91464f111306a094f86fe71b\", \"got_v8_revision\": \"ee927aaa58e688ad6aa0256b3929c1eeea0bebd5\", \"got_v8_revision_cp\": \"refs/heads/9.0.8@{#1}\", \"got_webrtc_revision\": \"29bd8638adb0a7294f7b8ae589fdd24077539dbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33030}\", \"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\": \"23e85cf80993ee7b6301b12be9277a9bc1edd468\", \"swarm_hashes_refs/heads/master(at){#844742}_without_patch\": {\"absl_hardening_tests\": \"ebfef63da7acc9e3e703c5bddec9f85f6be79f09\", \"accessibility_unittests\": \"67747df6058eda1648f523782aeced37edb210aa\", \"angle_unittests\": \"50afa90a68d209234d9132b8da6078de2c41e143\", \"app_shell_unittests\": \"0ea75a5c70353f022f0a70dff7b14082576a2744\", \"aura_unittests\": \"347b3d7a7bff20c67b8f31560e5a3b8ff5bb17c0\", \"base_unittests\": \"5b2e35517f5873e41aa68b4d90c33da56507f44f\", \"base_util_unittests\": \"a462d329a543e6a92d7fcf6dceaf1faf34cd2bfe\", \"blink_common_unittests\": \"80c4022d1ec488cd2172929b10c88a984705dfec\", \"blink_fuzzer_unittests\": \"68892a2ea40733c51315f3286c2e032f1339e78e\", \"blink_heap_unittests\": \"e84d786f51a0cc5f81b2436e727564713e94c8df\", \"blink_platform_unittests\": \"ef0c9c25e7f37724ee9ae8c5d2149d19f6628f50\", \"blink_unittests\": \"c92a725f8c7789dfc55efa1197c1ed9a65b332eb\", \"boringssl_crypto_tests\": \"d2a447f10f5e3f52a244c454d67043fe89c342dc\", \"boringssl_ssl_tests\": \"cfe3379698f021f6eaf1b17818fb78585246ab8a\", \"browser_switcher_bho_unittests\": \"90d791d55a314ff4959a27d49625a9b3ab38ec63\", \"browser_tests\": \"44c905bca1c61f6d6bc97d424d28b2cf69b245e8\", \"capture_unittests\": \"430eac7b27a9f2070af9f46a4df6900dc36033f3\", \"cast_unittests\": \"29cc3ad5706c270f9d7cbde994e451968fb98d55\", \"cc_unittests\": \"2751105bd595e1b41ccbfebb4b25272e66b7223c\", \"chrome_app_unittests\": \"596b18e3177b3554f00554cf78dc4b873370b31c\", \"chrome_cleaner_unittests\": \"42e4b11d3a2418c734eb5addadb9f3f383aca688\", \"chrome_elf_unittests\": \"a0f8d5dd29cc09679db897815bcee97a5e15d986\", \"chromedriver_unittests\": \"32e27086c710069946a738a69aa3c678a993cb9f\", \"components_browsertests\": \"072e9a91056ba2fd4077462ffd639b978b6ef346\", \"components_unittests\": \"33123ccfea0bb7f66f907984c46ce1c8dc4b0644\", \"compositor_unittests\": \"e626651b82ae8b654b8e629976d5eb46a0b6f9ee\", \"content_browsertests\": \"1188989d0fac498fd8103f596c0b0c6102f6067c\", \"content_unittests\": \"a442e59bb26390175d4fb01074c8f12c48d2436e\", \"courgette_unittests\": \"5e4d6453fb3b338f3b2d99f6d013538578f95ed2\", \"crashpad_tests\": \"1d9fe6da264ef4f997ecc5f0ef85426ec3bdc073\", \"cronet_tests\": \"5899a790c261a3e14955858dc709fc1618d6ccc3\", \"cronet_unittests\": \"708533885bf7745d492f81bab895bd318d4cd166\", \"crypto_unittests\": \"7f8137edf4dce3625cd62557beb93484eb10a521\", \"delayloads_unittests\": \"45ccb83e45480c9969265bee5fa875350807db06\", \"device_unittests\": \"54318bd9c0f0e46522e4cfd22634d3ddb1760bdf\", \"display_unittests\": \"280fb6d1f1c4303a80c20b9404ab363b6168c484\", \"elevation_service_unittests\": \"8a8773c40e6290ce5e8de51e5b6fca78c356de1f\", \"events_unittests\": \"f8a387209d8b8a61897cbe545fb4911a4a12d19a\", \"extensions_browsertests\": \"d69310f0d1e2d02d5d1cee81b3da8c979ad8c693\", \"extensions_unittests\": \"0b4203a38ffa916abbdd031dfb259b072733cb9b\", \"filesystem_service_unittests\": \"2eb3f67104df216b5d9bdd4000f450d00b2d3524\", \"gcm_unit_tests\": \"6834186ca7768460ddf5aefd3c1f59e2dc5df86b\", \"gcp_unittests\": \"8808aebd88983cd398560ee61a180e0b1e024529\", \"gfx_unittests\": \"5ed123eb1122b6d38671f0e83e073b8eb6328cd3\", \"gin_unittests\": \"e2a1942615849e70001f4c3b990e587cbef67656\", \"google_apis_unittests\": \"12d1020ac2a6f052663a96994c9555b8023010f4\", \"gpu_unittests\": \"a956b2dbbd097e7da76d7914a6e274aea83c4308\", \"gwp_asan_unittests\": \"4e0065d1d3388c9198d76ec7432a1768514d776e\", \"headless_browsertests\": \"baa63bc1431f2541c6fb290be47836a0f2a3b9ee\", \"headless_unittests\": \"005263d5cade621ffb82ebf01cca8f0cead60f2a\", \"install_static_unittests\": \"5742a47686c22ca1bc1108cc62a14428c9cebd11\", \"installer_util_unittests\": \"c78422c2608a4c7eaef0e7927792de7657d462c2\", \"interactive_ui_tests\": \"6fef432ca74429ab1f0b9463527e92e1f6fb19ab\", \"ipc_tests\": \"880e62e50159b1b7e3d36a7d3111cbc323ffcb70\", \"jingle_unittests\": \"a76ececcd4e20964865293e5d92f57de4fabeb40\", \"latency_unittests\": \"17a6acc7d0d08f9376007a80c282d0fa2e7533fb\", \"libjingle_xmpp_unittests\": \"b7db71bfa5bd4c75fcc7df17ed97cba3a89ced9a\", \"liburlpattern_unittests\": \"699759f09985b2d557af1ee7ce85bd2a0cdffc00\", \"media_blink_unittests\": \"f98a748701b465714879a66d05f4f72288abed78\", \"media_unittests\": \"b333540e1311104c88a7e2f74c9e77b80b054d67\", \"message_center_unittests\": \"04310e3bcd056d5917925ea3c925f40681c353d6\", \"midi_unittests\": \"209de91f90f79808fda664f24d8e87706298a49e\", \"mojo_core_unittests\": \"bd9b9ba70b7260cfca8b696c77e7bae32a232342\", \"mojo_unittests\": \"eb1d576774c09758dafc0e5775be722844d9c8ba\", \"nacl_loader_unittests\": \"71c35a0403551b6149de85d8e568daa18c7485f3\", \"native_theme_unittests\": \"c32b31c52e8e4617816a0c9916c162249b8aa344\", \"net_unittests\": \"ca15341b27ea899c98c131b77b51e23e3d6579e3\", \"notification_helper_unittests\": \"707d616fff6d48aa37d52c990ca269e2f5f38349\", \"pdf_unittests\": \"211d9e673c61c129c2131bd18bfbb4a36ad06974\", \"perfetto_unittests\": \"f08c96f4694893eae621b80abc55a4c6e7d3f1c0\", \"ppapi_unittests\": \"5712b11e02fd2d48ce71f6e3b4b87c1f59e65443\", \"printing_unittests\": \"6acd4dda63d188e8b7c716a67e036b5d480cc6e9\", \"remoting_unittests\": \"e170084989852d61045650c41775d66b434118de\", \"sbox_integration_tests\": \"bed360da394bf45b51aa9969a56f669331c62289\", \"sbox_unittests\": \"7fc8a80df0be42ada78ce8e2d8b32a15d9e45c12\", \"sbox_validation_tests\": \"521932972d2fe2c42b1662f22dfb588080b1ebd5\", \"service_manager_unittests\": \"b91f43950a3610cd5743ad3c34a23095f426350e\", \"services_unittests\": \"c989f48171b44adc5568cb1fd4704a2c8c603da4\", \"setup_unittests\": \"f59226b2eede989b841379af69b0c92cefd533fb\", \"shell_dialogs_unittests\": \"653ac1fba97499016de72f1affaa1b9784f7da1f\", \"skia_unittests\": \"bd7ab2e24a4addec2b341c421cae17d371582687\", \"snapshot_unittests\": \"0204fd4b3ecc48a47c53c34aca5a65864d329cdb\", \"sql_unittests\": \"39322d3848faac96bfdaac4035eefe88a09a0b46\", \"storage_unittests\": \"1802521786c64f2cdd8176ba6b3477f7a6434f48\", \"sync_integration_tests\": \"4c3b442fc91c11749b2f128ff77c405ea52c1459\", \"traffic_annotation_auditor_unittests\": \"27f7cbeb9cceb3b44ff1bcb5e3935853b9a62cf8\", \"ui_base_unittests\": \"adefe05601c5d0e660a4c079aac22094c2b22efa\", \"ui_touch_selection_unittests\": \"9a476e869d1986f23671c0279037acc49b9e57cc\", \"unit_tests\": \"48d375dc179240cd74aa33596fbdcde673768d30\", \"updater_tests\": \"f401c58212e1925123c11e3132953d5f4c3f9a8f\", \"url_unittests\": \"8ecf472720e7beb6a9ba6e77338ff8446a14ea03\", \"views_unittests\": \"a0f4e14818ce2c1b9d8df6c228fb18d1ba3e6097\", \"viz_unittests\": \"4ae078ab0fa0f7d9547b281938f66c376d9bbc4f\", \"vr_common_unittests\": \"ef2db067ca1feae24ddb2892fc2ff0401a5c95e6\", \"vr_pixeltests\": \"cbd14f0cb229bf9089e5ce907b312c6e984f7b16\", \"weblayer_browsertests\": \"9ab6c2b4165635cd794d2e9a53e460b098e14f2a\", \"weblayer_unittests\": \"ed6df97e7c46053b376ebe9e0836e164e4d89885\", \"wm_unittests\": \"28596e7b1a2c70713c3715b278ab6f6ad20593da\", \"wtf_unittests\": \"a719f370fd1d910699c91ede01e7e3950ebf89b0\", \"zlib_unittests\": \"238e463f152dedf6a97cc8a7e9c9c09113900edc\", \"zucchini_unittests\": \"0a14845efc482728a6d8820cac93ff13408402e8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-0-nszv\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ECKIncognitoEncryptedMediaTest.FileIO\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611060250116580",
"status": "COMPLETED",
"status_changed_ts": "1611060250399756",
"tags": [
"build_address:luci.chromium.ci/win-asan/16892",
"builder:win-asan",
"buildset:commit/git/23e85cf80993ee7b6301b12be9277a9bc1edd468",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/23e85cf80993ee7b6301b12be9277a9bc1edd468",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023104669774449504",
"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/8857674607662030064/+/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:51337e0528469610",
"user_agent:luci-scheduler"
],
"updated_ts": "1611063492668981",
"url": "https://ci.chromium.org/b/8857674607662030064",
"utcnow_ts": "1611063493139690"
}
}
[13:38:13.159] Invocation finished in 54m8.760903911s with status FAILED