[10:34:50.746] New invocation is queued and will start shortly
[10:34:51.897] Starting the invocation (attempt 1)
[10:34:51.965] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:34:51.969] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:34:51.969] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023475187952416160",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"24afdd1730b01f22fff8e962073cf19aed331677\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023475187952416160",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/24afdd1730b01f22fff8e962073cf19aed331677",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/24afdd1730b01f22fff8e962073cf19aed331677",
"gitiles_ref:refs/heads/master"
]
}
[10:34:52.912] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610706892096167",
"id": "8858045125871645408",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"24afdd1730b01f22fff8e962073cf19aed331677\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610706892563763",
"tags": [
"build_address:luci.chromium.ci/win-asan/16836",
"builder:win-asan",
"buildset:commit/git/24afdd1730b01f22fff8e962073cf19aed331677",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/24afdd1730b01f22fff8e962073cf19aed331677",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023475187952416160",
"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/8858045125871645408/+/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": "1610706892563871",
"url": "https://ci.chromium.org/b/8858045125871645408",
"utcnow_ts": "1610706892894915"
}
}
[10:34:52.912] Task URL: https://ci.chromium.org/b/8858045125871645408
[10:34:52.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:2:0) after 1m0s
[10:34:55.206] Received PubSub notification, asking Buildbucket for the build status
[10:34:55.277] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:52.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:2:0)
[10:35:52.949] Timer tick, asking Buildbucket for the build status
[10:35:53.194] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:53.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:4:0) after 1m0s
[10:36:53.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:4:0)
[10:36:53.354] Timer tick, asking Buildbucket for the build status
[10:36:53.635] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:53.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:5:0) after 1m0s
[10:37:53.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:5:0)
[10:37:53.656] Timer tick, asking Buildbucket for the build status
[10:37:53.773] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:53.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:6:0) after 1m0s
[10:38:53.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:6:0)
[10:38:53.916] Timer tick, asking Buildbucket for the build status
[10:38:54.058] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:54.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:7:0) after 1m0s
[10:39:54.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:7:0)
[10:39:54.211] Timer tick, asking Buildbucket for the build status
[10:39:54.426] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:54.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:8:0) after 1m0s
[10:40:54.590] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:8:0)
[10:40:54.590] Timer tick, asking Buildbucket for the build status
[10:40:54.799] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:54.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:9:0) after 1m0s
[10:41:54.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:9:0)
[10:41:54.831] Timer tick, asking Buildbucket for the build status
[10:41:54.901] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:54.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:10:0) after 1m0s
[10:42:54.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:10:0)
[10:42:54.936] Timer tick, asking Buildbucket for the build status
[10:42:55.020] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:55.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:11:0) after 1m0s
[10:43:55.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:11:0)
[10:43:55.046] Timer tick, asking Buildbucket for the build status
[10:43:55.112] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:55.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:12:0) after 1m0s
[10:44:55.142] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:12:0)
[10:44:55.142] Timer tick, asking Buildbucket for the build status
[10:44:55.608] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:55.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:13:0) after 1m0s
[10:45:55.634] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:13:0)
[10:45:55.634] Timer tick, asking Buildbucket for the build status
[10:45:55.933] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:55.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:14:0) after 1m0s
[10:46:55.983] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:14:0)
[10:46:55.983] Timer tick, asking Buildbucket for the build status
[10:46:57.360] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:57.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:15:0) after 1m0s
[10:47:57.356] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:15:0)
[10:47:57.356] Timer tick, asking Buildbucket for the build status
[10:47:57.473] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:57.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:16:0) after 1m0s
[10:48:57.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:16:0)
[10:48:57.593] Timer tick, asking Buildbucket for the build status
[10:48:57.712] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:57.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:17:0) after 1m0s
[10:49:57.735] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:17:0)
[10:49:57.735] Timer tick, asking Buildbucket for the build status
[10:49:58.246] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:58.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:18:0) after 1m0s
[10:50:58.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:18:0)
[10:50:58.288] Timer tick, asking Buildbucket for the build status
[10:50:58.402] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:58.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:19:0) after 1m0s
[10:51:58.469] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:19:0)
[10:51:58.469] Timer tick, asking Buildbucket for the build status
[10:51:58.821] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:58.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:20:0) after 1m0s
[10:52:58.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:20:0)
[10:52:58.843] Timer tick, asking Buildbucket for the build status
[10:52:58.942] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:58.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:21:0) after 1m0s
[10:53:59.072] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:21:0)
[10:53:59.072] Timer tick, asking Buildbucket for the build status
[10:53:59.214] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:59.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:22:0) after 1m0s
[10:54:59.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:22:0)
[10:54:59.240] Timer tick, asking Buildbucket for the build status
[10:54:59.810] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:59.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:23:0) after 1m0s
[10:55:59.852] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:23:0)
[10:55:59.852] Timer tick, asking Buildbucket for the build status
[10:55:59.952] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:59.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:24:0) after 1m0s
[10:57:00.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:24:0)
[10:57:00.046] Timer tick, asking Buildbucket for the build status
[10:57:00.223] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:00.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:25:0) after 1m0s
[10:58:00.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:25:0)
[10:58:00.248] Timer tick, asking Buildbucket for the build status
[10:58:00.366] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:00.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:26:0) after 1m0s
[10:59:00.417] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:26:0)
[10:59:00.417] Timer tick, asking Buildbucket for the build status
[10:59:00.810] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:00.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:27:0) after 1m0s
[11:00:00.882] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:27:0)
[11:00:00.882] Timer tick, asking Buildbucket for the build status
[11:00:01.052] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:01.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:28:0) after 1m0s
[11:01:01.394] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:28:0)
[11:01:01.394] Timer tick, asking Buildbucket for the build status
[11:01:01.640] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:01.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:29:0) after 1m0s
[11:02:01.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:29:0)
[11:02:01.675] Timer tick, asking Buildbucket for the build status
[11:02:01.770] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:01.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:30:0) after 1m0s
[11:03:01.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:30:0)
[11:03:01.802] Timer tick, asking Buildbucket for the build status
[11:03:02.193] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:02.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:31:0) after 1m0s
[11:04:02.245] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:31:0)
[11:04:02.245] Timer tick, asking Buildbucket for the build status
[11:04:02.339] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:02.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:32:0) after 1m0s
[11:05:02.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:32:0)
[11:05:02.599] Timer tick, asking Buildbucket for the build status
[11:05:02.981] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:02.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:33:0) after 1m0s
[11:06:03.171] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:33:0)
[11:06:03.171] Timer tick, asking Buildbucket for the build status
[11:06:03.390] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:03.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:34:0) after 1m0s
[11:07:03.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:34:0)
[11:07:03.408] Timer tick, asking Buildbucket for the build status
[11:07:03.478] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:03.478] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:35:0) after 1m0s
[11:08:03.540] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:35:0)
[11:08:03.540] Timer tick, asking Buildbucket for the build status
[11:08:04.026] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:04.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:36:0) after 1m0s
[11:09:04.185] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:36:0)
[11:09:04.185] Timer tick, asking Buildbucket for the build status
[11:09:04.624] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:04.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:37:0) after 1m0s
[11:10:04.722] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:37:0)
[11:10:04.722] Timer tick, asking Buildbucket for the build status
[11:10:05.001] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:05.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:38:0) after 1m0s
[11:11:05.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:38:0)
[11:11:05.126] Timer tick, asking Buildbucket for the build status
[11:11:05.275] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:05.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:39:0) after 1m0s
[11:12:05.394] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:39:0)
[11:12:05.394] Timer tick, asking Buildbucket for the build status
[11:12:05.959] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:05.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:40:0) after 1m0s
[11:13:06.065] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:40:0)
[11:13:06.065] Timer tick, asking Buildbucket for the build status
[11:13:06.492] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:06.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:41:0) after 1m0s
[11:14:06.548] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:41:0)
[11:14:06.548] Timer tick, asking Buildbucket for the build status
[11:14:07.190] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:07.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:42:0) after 1m0s
[11:15:07.326] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:42:0)
[11:15:07.326] Timer tick, asking Buildbucket for the build status
[11:15:07.717] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:07.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:43:0) after 1m0s
[11:16:07.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:43:0)
[11:16:07.826] Timer tick, asking Buildbucket for the build status
[11:16:07.890] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:07.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:44:0) after 1m0s
[11:17:07.974] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:44:0)
[11:17:07.974] Timer tick, asking Buildbucket for the build status
[11:17:08.087] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:08.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:45:0) after 1m0s
[11:18:08.204] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:45:0)
[11:18:08.204] Timer tick, asking Buildbucket for the build status
[11:18:08.432] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:08.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:46:0) after 1m0s
[11:19:08.470] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:46:0)
[11:19:08.470] Timer tick, asking Buildbucket for the build status
[11:19:08.599] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:08.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:47:0) after 1m0s
[11:20:08.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:47:0)
[11:20:08.605] Timer tick, asking Buildbucket for the build status
[11:20:08.854] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:08.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:48:0) after 1m0s
[11:21:08.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:48:0)
[11:21:08.902] Timer tick, asking Buildbucket for the build status
[11:21:09.135] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:09.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:49:0) after 1m0s
[11:22:09.188] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:49:0)
[11:22:09.188] Timer tick, asking Buildbucket for the build status
[11:22:09.345] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:09.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:50:0) after 1m0s
[11:23:09.423] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:50:0)
[11:23:09.424] Timer tick, asking Buildbucket for the build status
[11:23:09.496] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:09.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:51:0) after 1m0s
[11:24:09.704] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:51:0)
[11:24:09.704] Timer tick, asking Buildbucket for the build status
[11:24:10.386] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:10.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:52:0) after 1m0s
[11:25:10.374] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:52:0)
[11:25:10.374] Timer tick, asking Buildbucket for the build status
[11:25:10.892] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:10.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:53:0) after 1m0s
[11:26:10.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:53:0)
[11:26:10.963] Timer tick, asking Buildbucket for the build status
[11:26:11.039] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:11.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:54:0) after 1m0s
[11:27:11.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:54:0)
[11:27:11.077] Timer tick, asking Buildbucket for the build status
[11:27:11.487] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:11.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:55:0) after 1m0s
[11:28:11.557] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:55:0)
[11:28:11.558] Timer tick, asking Buildbucket for the build status
[11:28:11.727] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:11.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:56:0) after 1m0s
[11:29:11.790] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:56:0)
[11:29:11.790] Timer tick, asking Buildbucket for the build status
[11:29:11.877] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:11.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:57:0) after 1m0s
[11:30:11.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:57:0)
[11:30:11.914] Timer tick, asking Buildbucket for the build status
[11:30:12.023] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:12.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:58:0) after 1m0s
[11:31:12.093] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:58:0)
[11:31:12.093] Timer tick, asking Buildbucket for the build status
[11:31:12.253] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:12.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:59:0) after 1m0s
[11:32:12.452] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:59:0)
[11:32:12.452] Timer tick, asking Buildbucket for the build status
[11:32:13.069] Build 8858045125871645408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:13.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023475187952416160:60:0) after 1m0s
[11:32:54.975] Received PubSub notification, asking Buildbucket for the build status
[11:32:55.052] Build 8858045125871645408: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:32:55.052] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610710374126183",
"created_by": "project:chromium",
"created_ts": "1610706892096167",
"failure_reason": "BUILD_FAILURE",
"id": "8858045125871645408",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"24afdd1730b01f22fff8e962073cf19aed331677\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- FormAutofillTest.FillFormWithPlaceholderValues\\n\\n- PasswordAutofillAgentTest.SendPasswordFormsTest_CannotCreatePasswordForm\\n\\n- ChromeContentRendererClientSearchBoxTest.RewriteThumbnailURL\\n\\n- PagePasswordsAnalyserTest.InferredPasswordAutocompleteAttributes\\n\\n- ...3 more failure(s) (7 total)...\"}, \"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\": \"24afdd1730b01f22fff8e962073cf19aed331677\", \"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-3-nb2x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16836, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-1\", \"got_angle_revision\": \"29eeb610bd49e80a8109a6b42f2c95adcc619099\", \"got_dawn_revision\": \"5a6fda1a6fcc99553bab1411e2159cf962b6a36d\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"24afdd1730b01f22fff8e962073cf19aed331677\", \"got_revision_cp\": \"refs/heads/master@{#844014}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"aedd133cd85f40f92c304776d240a8a3503d1d71\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#1}\", \"got_webrtc_revision\": \"7acc2d9fe3a6e3c4d8881d2bdfc9b8968a724cd5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32986}\", \"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\": \"24afdd1730b01f22fff8e962073cf19aed331677\", \"swarm_hashes_refs/heads/master(at){#844014}_without_patch\": {\"absl_hardening_tests\": \"e80e92a86c11a52a4cf3f675de43aec506c9e3ea\", \"accessibility_unittests\": \"60d16f1bd7bd29c9437decd05e1d25f23571fe75\", \"angle_unittests\": \"b915ae8c3e0e4357f1ac8e946c5dc3dcd81adeb1\", \"app_shell_unittests\": \"abd06d2ddfa5dca86f243d404d2b831b04f31913\", \"aura_unittests\": \"4556204f7c3cfc06a087dba653ab136d1e9f9f6e\", \"base_unittests\": \"2a7cdb02710e9f689e3db84aae510e9a4faaef75\", \"base_util_unittests\": \"531aa59189cf3c84d9310590aa31901cf8fab6be\", \"blink_common_unittests\": \"37f12a7a23c5e48c4bbb9895d3240fd3804c9208\", \"blink_fuzzer_unittests\": \"4b1d1447121a9f7d5a8eea25ba02007df15069fe\", \"blink_heap_unittests\": \"f3337ae6a072e0f16b47f1d0b747ff2aba9acb4e\", \"blink_platform_unittests\": \"3a2812645e9e9aa581f96e2f128cf94ddf1fec24\", \"blink_unittests\": \"2a21abd1d6cf5a3edc398dda2da92dd8e6a401d0\", \"boringssl_crypto_tests\": \"b995521b6f19b3b11577bfa9e47f07c1b5caaf53\", \"boringssl_ssl_tests\": \"cdd021a97166d08e7f1c5650219ec2c0451fd25b\", \"browser_switcher_bho_unittests\": \"d59b8f24bd6d2d6214b7eb96648da77ae91641d1\", \"browser_tests\": \"6b95907c121ca643ace508f82bb9d2125abdd82e\", \"capture_unittests\": \"d41a14ce46f2e11ff86181219895f2da180ac81a\", \"cast_unittests\": \"28edcd99c1a459b1094f62472063188062ab2e80\", \"cc_unittests\": \"d870ec7b9e43111d42956a3a074f634c9abdb268\", \"chrome_app_unittests\": \"7372fd3abdc06641ec7af939a6bff959cf227a1a\", \"chrome_cleaner_unittests\": \"60c80ee1fd45f9cb72722ea186978ff6a80d8514\", \"chrome_elf_unittests\": \"d11dd095a693004f378eda05b9f8148843899421\", \"chromedriver_unittests\": \"c7d125f599eb549c2d4894b32dba3c99f0776702\", \"components_browsertests\": \"26aef0fe57f68b12d69e7b477954bac872af1445\", \"components_unittests\": \"b4ea674226ada01a656f23c3fb269c2ee284559f\", \"compositor_unittests\": \"bfde7cab24952063211b943b6c890b4b9409a6b8\", \"content_browsertests\": \"9ddfbca5b071a1da7eb923cf35a56f5157032394\", \"content_unittests\": \"e3f277b0f401b9bf072772fbe3629220670580b9\", \"courgette_unittests\": \"b8b6c92c7b06b4d764c063717d0a5955a98de60b\", \"crashpad_tests\": \"06220aa4edecc39e23a185493813b2c21b5b94fd\", \"cronet_tests\": \"002b430a417794ffae98e47832e4355ac354d4ce\", \"cronet_unittests\": \"043b0f0c7f37a21e12e99c73c280756808ad6079\", \"crypto_unittests\": \"e2b0d161341807935eac59ec866a6fcea383d0ed\", \"delayloads_unittests\": \"4821186875e63ecd3315a98aa7a0e275745ad4d9\", \"device_unittests\": \"596afe3eca5163579f8a470b5e34f3cb03c58195\", \"display_unittests\": \"6777e0b6a92d147801d90e61d37fd44b1096f88b\", \"elevation_service_unittests\": \"7cddf03e80ea903af107665aff349f927e687418\", \"events_unittests\": \"a41b725d99a059bfc0a1c39b9ad8abd2dd44953f\", \"extensions_browsertests\": \"7c49994e370fe63c20020bce86e09ef25cc0a82b\", \"extensions_unittests\": \"9dbb9f53f7af1b10c6e8d77239174f0ff89982eb\", \"filesystem_service_unittests\": \"1a0a90ec0e5e56ae3e1106d44d642ed86eb571b7\", \"gcm_unit_tests\": \"a074ca76f8de2582d757343244ec1a6c6540711b\", \"gcp_unittests\": \"081f8ff80a7d4d3d10118abc7f5ea1309bcf83b0\", \"gfx_unittests\": \"8d9fc8d1f1f70d9f89d102c73938e38c4af2cd1f\", \"gin_unittests\": \"a36ae523b97dbe94b0fdea36d7b2f8f8f921d8c6\", \"google_apis_unittests\": \"49100d51b9f4f4f2c9a3a893561d6f36f6ef2ef3\", \"gpu_unittests\": \"bb136f5bd5a587baecce498dc8c398d84bde8ade\", \"gwp_asan_unittests\": \"6d1b502b740bf4628309e3c928dcff3d0295e956\", \"headless_browsertests\": \"d048d0b4491a3e00965a378ba98f8742bb772043\", \"headless_unittests\": \"5422ea0ac71a4fb47ef9475e1bb0072b238747d9\", \"install_static_unittests\": \"d49b57e36d9f580b2207b3a09bab7dc64c1c508a\", \"installer_util_unittests\": \"e3d2d2468c09cc77dd82f0504e669552990b3b01\", \"interactive_ui_tests\": \"74e2b6a58b630213abf39457c600f8e51bb18ecd\", \"ipc_tests\": \"04b29ea2dcac58398dc589b81059bb615997fce1\", \"jingle_unittests\": \"36fd69b770404dcc6a40de0af27864991a14cb0e\", \"latency_unittests\": \"a52d62052f352647292a56f64c43126e68a233f8\", \"libjingle_xmpp_unittests\": \"24ec27fab270c2c07d1aae3a917d1d4592bd194f\", \"liburlpattern_unittests\": \"495c955f01e6fdcdefb5d15c755815bb921457ca\", \"media_blink_unittests\": \"8042589ec4705c31467eb6a347c14dbc98e4fd75\", \"media_unittests\": \"62b565c5466c5591217c1bd0efe767d7bf723a69\", \"message_center_unittests\": \"6e521e24ad7c0fb9046e2709cba56ab5422636be\", \"midi_unittests\": \"63ef9c56554fdcd74f5124fb04fc6dcc32676df1\", \"mojo_core_unittests\": \"f6710360f13b359ca507b66bfd8b784e8620216d\", \"mojo_unittests\": \"f44ad5d2ba2bb685ebb3e1fa47dfe63bc4d59aa5\", \"nacl_loader_unittests\": \"12f9db40a7c76c53d397b764890d041c08adf386\", \"native_theme_unittests\": \"d027858932147252f7713e50b6dbac722a899b95\", \"net_unittests\": \"f0ba9bf80f7fdccd700c8b6a8a771bde30eac103\", \"notification_helper_unittests\": \"b88829f11c0039d055c4e8d02361b010f6d73161\", \"pdf_unittests\": \"018b75f0d3d685e9ae534397d557595763df35af\", \"perfetto_unittests\": \"624ce3abbe2f373f9756a323bfb69ca848cc380c\", \"ppapi_unittests\": \"849bc529e848bde0e400e01bf6d21951481d1151\", \"printing_unittests\": \"644ba67693a6278ef1b67df991774626f1b2fb06\", \"remoting_unittests\": \"ca73dfabe10d65e15bb537ef1c1f76b77234dd61\", \"sbox_integration_tests\": \"b97a238235ba2e9b70ff904ee1cfcd5b6dca02dc\", \"sbox_unittests\": \"e6384c634732dc697d9968a7896a260ce5f4ba80\", \"sbox_validation_tests\": \"a445ad3b3d19612cdc2cf663ec2fb4c9a5646b8d\", \"service_manager_unittests\": \"de521c64743537dbee403d93eb92542657069db1\", \"services_unittests\": \"469434f1dc0e7019d9d8b3137ed5a5e4904873ca\", \"setup_unittests\": \"d322123ec3a521892de2c330838d7b713c690566\", \"shell_dialogs_unittests\": \"49548c0904852ba8c7dab7eeb9473fb8fb62ce95\", \"skia_unittests\": \"819b1ea362c95a27279001f2bee92b9bd1eb2aee\", \"snapshot_unittests\": \"9d807ffbdb31845b68434738a4c314f12d4d011d\", \"sql_unittests\": \"e5adab62a9ed29fb63800cf9acc67796c9ed1425\", \"storage_unittests\": \"19df47007a866a999b25d27759fc8289bcf4eeee\", \"sync_integration_tests\": \"26845885063fd266f2fb828e214b2d4bed0fab2b\", \"traffic_annotation_auditor_unittests\": \"5ca5b0dfb6e577335278e6a58d35ac57539b9360\", \"ui_base_unittests\": \"44649840981ba7b18f9c3c1a0911904638faa2f9\", \"ui_touch_selection_unittests\": \"eeb1f8d402a0fe78a3b7e2c7f058e9ccbc2a1192\", \"unit_tests\": \"9ba2fda173432651186def3857213d734f7b4a2b\", \"updater_tests\": \"908b6ae419f0b15f7c07af76723f44c32213cb8f\", \"url_unittests\": \"ca5c3c0079d3547037355463520ce302894f4548\", \"views_unittests\": \"e179735fe65646e32655b70a2f0935ba98115314\", \"viz_unittests\": \"a0d11f5d0ed8d0b951e30e5700e63b6e6accb29e\", \"vr_common_unittests\": \"f8e6c0617d64d11cdbf94d1a78068483e4ea7aa3\", \"vr_pixeltests\": \"eeb067f58861546109bc5dfb73239268fd16812c\", \"weblayer_browsertests\": \"3f1690e2c60e106ed8d7315e891c4c8bd9185a67\", \"weblayer_unittests\": \"0faae531817234908bceafe6111d30bc1b6e0359\", \"wm_unittests\": \"02bc847e1fe3a3f7462ebf1dfe843b7ac76ed81b\", \"wtf_unittests\": \"963a652cc992022bbeb8a8703df86de2dfdf6ee5\", \"zlib_unittests\": \"2bac7ff559dcb01788a3ee11922da5c6ce43ca1e\", \"zucchini_unittests\": \"e4aae04e68d3e116a1918ef7332ae6230c43894f\"}}, \"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-3-nb2x\"], \"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- FormAutofillTest.FillFormWithPlaceholderValues\\n\\n- PasswordAutofillAgentTest.SendPasswordFormsTest_CannotCreatePasswordForm\\n\\n- ChromeContentRendererClientSearchBoxTest.RewriteThumbnailURL\\n\\n- PagePasswordsAnalyserTest.InferredPasswordAutocompleteAttributes\\n\\n- ...3 more failure(s) (7 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610706894414491",
"status": "COMPLETED",
"status_changed_ts": "1610706894900405",
"tags": [
"build_address:luci.chromium.ci/win-asan/16836",
"builder:win-asan",
"buildset:commit/git/24afdd1730b01f22fff8e962073cf19aed331677",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/24afdd1730b01f22fff8e962073cf19aed331677",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023475187952416160",
"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/8858045125871645408/+/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:511e6e426ee13710",
"user_agent:luci-scheduler"
],
"updated_ts": "1610710374451327",
"url": "https://ci.chromium.org/b/8858045125871645408",
"utcnow_ts": "1610710375040157"
}
}
[11:32:55.052] Invocation finished in 58m4.324479475s with status FAILED