[07:31:26.394] New invocation is queued and will start shortly
[07:31:27.576] Starting the invocation (attempt 1)
[07:31:27.612] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:31:27.612] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:31:27.612] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028922544836368544",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"38163d72a9d7fa2383c78055cea488f6ed468dc7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028922544836368544",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/38163d72a9d7fa2383c78055cea488f6ed468dc7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/38163d72a9d7fa2383c78055cea488f6ed468dc7",
"gitiles_ref:refs/heads/master"
]
}
[07:31:28.298] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605511887703783",
"id": "8863492482798207920",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"38163d72a9d7fa2383c78055cea488f6ed468dc7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605511888128199",
"tags": [
"build_address:luci.chromium.ci/win-asan/15661",
"builder:win-asan",
"buildset:commit/git/38163d72a9d7fa2383c78055cea488f6ed468dc7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/38163d72a9d7fa2383c78055cea488f6ed468dc7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028922544836368544",
"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/8863492482798207920/+/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": "1605511888128314",
"url": "https://ci.chromium.org/b/8863492482798207920",
"utcnow_ts": "1605511888289610"
}
}
[07:31:28.298] Task URL: https://ci.chromium.org/b/8863492482798207920
[07:31:28.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:2:0) after 1m0s
[07:31:30.917] Received PubSub notification, asking Buildbucket for the build status
[07:31:30.993] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:28.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:2:0)
[07:32:28.389] Timer tick, asking Buildbucket for the build status
[07:32:28.502] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:28.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:4:0) after 1m0s
[07:33:28.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:4:0)
[07:33:28.510] Timer tick, asking Buildbucket for the build status
[07:33:28.631] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:28.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:5:0) after 1m0s
[07:34:28.671] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:5:0)
[07:34:28.671] Timer tick, asking Buildbucket for the build status
[07:34:28.873] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:28.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:6:0) after 1m0s
[07:35:28.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:6:0)
[07:35:28.930] Timer tick, asking Buildbucket for the build status
[07:35:29.102] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:29.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:7:0) after 1m0s
[07:36:29.194] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:7:0)
[07:36:29.194] Timer tick, asking Buildbucket for the build status
[07:36:29.325] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:29.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:8:0) after 1m0s
[07:37:29.349] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:8:0)
[07:37:29.349] Timer tick, asking Buildbucket for the build status
[07:37:29.414] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:29.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:9:0) after 1m0s
[07:38:29.483] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:9:0)
[07:38:29.483] Timer tick, asking Buildbucket for the build status
[07:38:29.548] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:29.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:10:0) after 1m0s
[07:39:29.581] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:10:0)
[07:39:29.581] Timer tick, asking Buildbucket for the build status
[07:39:29.654] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:29.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:11:0) after 1m0s
[07:40:29.635] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:11:0)
[07:40:29.635] Timer tick, asking Buildbucket for the build status
[07:40:29.709] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:29.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:12:0) after 1m0s
[07:41:29.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:12:0)
[07:41:29.729] Timer tick, asking Buildbucket for the build status
[07:41:29.866] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:29.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:13:0) after 1m0s
[07:42:29.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:13:0)
[07:42:29.887] Timer tick, asking Buildbucket for the build status
[07:42:31.247] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:31.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:14:0) after 1m0s
[07:43:31.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:14:0)
[07:43:31.343] Timer tick, asking Buildbucket for the build status
[07:43:31.601] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:31.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:15:0) after 1m0s
[07:44:34.088] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:15:0)
[07:44:34.088] Timer tick, asking Buildbucket for the build status
[07:44:34.344] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:34.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:16:0) after 1m0s
[07:45:34.696] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:16:0)
[07:45:34.696] Timer tick, asking Buildbucket for the build status
[07:45:34.799] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:34.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:17:0) after 1m0s
[07:46:34.847] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:17:0)
[07:46:34.847] Timer tick, asking Buildbucket for the build status
[07:46:34.995] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:34.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:18:0) after 1m0s
[07:47:35.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:18:0)
[07:47:35.062] Timer tick, asking Buildbucket for the build status
[07:47:35.593] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:35.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:19:0) after 1m0s
[07:48:35.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:19:0)
[07:48:35.753] Timer tick, asking Buildbucket for the build status
[07:48:35.880] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:35.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:20:0) after 1m0s
[07:49:35.987] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:20:0)
[07:49:35.987] Timer tick, asking Buildbucket for the build status
[07:49:36.153] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:36.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:21:0) after 1m0s
[07:50:36.289] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:21:0)
[07:50:36.289] Timer tick, asking Buildbucket for the build status
[07:50:36.408] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:36.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:22:0) after 1m0s
[07:51:36.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:22:0)
[07:51:36.524] Timer tick, asking Buildbucket for the build status
[07:51:36.649] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:36.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:23:0) after 1m0s
[07:52:36.706] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:23:0)
[07:52:36.706] Timer tick, asking Buildbucket for the build status
[07:52:36.830] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:36.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:24:0) after 1m0s
[07:53:36.907] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:24:0)
[07:53:36.907] Timer tick, asking Buildbucket for the build status
[07:53:37.027] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:37.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:25:0) after 1m0s
[07:54:37.033] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:25:0)
[07:54:37.033] Timer tick, asking Buildbucket for the build status
[07:54:37.158] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:37.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:26:0) after 1m0s
[07:55:37.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:26:0)
[07:55:37.242] Timer tick, asking Buildbucket for the build status
[07:55:37.577] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:37.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:27:0) after 1m0s
[07:56:37.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:27:0)
[07:56:37.607] Timer tick, asking Buildbucket for the build status
[07:56:37.741] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:37.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:28:0) after 1m0s
[07:57:37.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:28:0)
[07:57:37.840] Timer tick, asking Buildbucket for the build status
[07:57:37.945] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:37.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:29:0) after 1m0s
[07:58:37.961] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:29:0)
[07:58:37.961] Timer tick, asking Buildbucket for the build status
[07:58:38.167] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:38.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:30:0) after 1m0s
[07:59:38.198] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:30:0)
[07:59:38.198] Timer tick, asking Buildbucket for the build status
[07:59:38.506] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:38.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:31:0) after 1m0s
[08:00:38.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:31:0)
[08:00:38.604] Timer tick, asking Buildbucket for the build status
[08:00:38.925] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:38.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:32:0) after 1m0s
[08:01:38.951] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:32:0)
[08:01:38.951] Timer tick, asking Buildbucket for the build status
[08:01:39.083] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:39.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:33:0) after 1m0s
[08:02:39.119] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:33:0)
[08:02:39.119] Timer tick, asking Buildbucket for the build status
[08:02:39.512] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:39.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:34:0) after 1m0s
[08:03:39.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:34:0)
[08:03:39.531] Timer tick, asking Buildbucket for the build status
[08:03:39.608] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:39.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:35:0) after 1m0s
[08:04:39.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:35:0)
[08:04:39.692] Timer tick, asking Buildbucket for the build status
[08:04:39.803] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:39.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:36:0) after 1m0s
[08:05:39.868] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:36:0)
[08:05:39.868] Timer tick, asking Buildbucket for the build status
[08:05:40.668] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:40.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:37:0) after 1m0s
[08:06:40.735] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:37:0)
[08:06:40.735] Timer tick, asking Buildbucket for the build status
[08:06:40.858] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:40.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:38:0) after 1m0s
[08:07:40.881] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:38:0)
[08:07:40.881] Timer tick, asking Buildbucket for the build status
[08:07:41.018] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:41.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:39:0) after 1m0s
[08:08:41.149] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:39:0)
[08:08:41.149] Timer tick, asking Buildbucket for the build status
[08:08:41.305] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:41.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:40:0) after 1m0s
[08:09:41.416] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:40:0)
[08:09:41.416] Timer tick, asking Buildbucket for the build status
[08:09:41.514] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:41.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:41:0) after 1m0s
[08:10:41.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:41:0)
[08:10:41.574] Timer tick, asking Buildbucket for the build status
[08:10:41.663] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:41.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:42:0) after 1m0s
[08:11:41.696] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:42:0)
[08:11:41.696] Timer tick, asking Buildbucket for the build status
[08:11:41.978] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:41.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:43:0) after 1m0s
[08:12:42.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:43:0)
[08:12:42.010] Timer tick, asking Buildbucket for the build status
[08:12:43.144] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:43.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:44:0) after 1m0s
[08:13:43.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:44:0)
[08:13:43.179] Timer tick, asking Buildbucket for the build status
[08:13:43.415] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:43.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:45:0) after 1m0s
[08:14:43.494] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:45:0)
[08:14:43.494] Timer tick, asking Buildbucket for the build status
[08:14:44.323] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:44.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:46:0) after 1m0s
[08:15:44.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:46:0)
[08:15:44.353] Timer tick, asking Buildbucket for the build status
[08:15:44.442] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:44.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:47:0) after 1m0s
[08:16:44.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:47:0)
[08:16:44.505] Timer tick, asking Buildbucket for the build status
[08:16:44.695] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:44.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:48:0) after 1m0s
[08:17:44.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:48:0)
[08:17:44.841] Timer tick, asking Buildbucket for the build status
[08:17:45.007] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:45.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:49:0) after 1m0s
[08:18:45.148] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:49:0)
[08:18:45.148] Timer tick, asking Buildbucket for the build status
[08:18:45.588] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:45.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:50:0) after 1m0s
[08:19:45.580] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:50:0)
[08:19:45.580] Timer tick, asking Buildbucket for the build status
[08:19:45.848] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:45.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:51:0) after 1m0s
[08:20:45.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:51:0)
[08:20:45.880] Timer tick, asking Buildbucket for the build status
[08:20:46.065] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:46.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:52:0) after 1m0s
[08:21:46.096] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:52:0)
[08:21:46.096] Timer tick, asking Buildbucket for the build status
[08:21:46.241] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:46.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:53:0) after 1m0s
[08:22:46.279] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:53:0)
[08:22:46.279] Timer tick, asking Buildbucket for the build status
[08:22:46.693] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:46.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:54:0) after 1m0s
[08:23:46.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:54:0)
[08:23:46.777] Timer tick, asking Buildbucket for the build status
[08:23:46.843] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:46.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:55:0) after 1m0s
[08:24:46.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:55:0)
[08:24:46.855] Timer tick, asking Buildbucket for the build status
[08:24:46.932] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:46.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:56:0) after 1m0s
[08:25:47.021] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:56:0)
[08:25:47.021] Timer tick, asking Buildbucket for the build status
[08:25:47.157] Build 8863492482798207920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:47.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028922544836368544:57:0) after 1m0s
[08:26:14.031] Received PubSub notification, asking Buildbucket for the build status
[08:26:14.304] Build 8863492482798207920: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:26:14.304] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605515171892608",
"created_by": "project:chromium",
"created_ts": "1605511887703783",
"failure_reason": "BUILD_FAILURE",
"id": "8863492482798207920",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"38163d72a9d7fa2383c78055cea488f6ed468dc7\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed.\"}, \"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\": \"38163d72a9d7fa2383c78055cea488f6ed468dc7\", \"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-n4wf\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15661, \"clang_revision\": \"llvmorg-12-init-11462-g418f18c6-1\", \"got_angle_revision\": \"f46e6201b40bdee3e0b79d5d97660fc302fd76f5\", \"got_dawn_revision\": \"575729e8dd25e0ac4631c9739a82118ea3545c6b\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"38163d72a9d7fa2383c78055cea488f6ed468dc7\", \"got_revision_cp\": \"refs/heads/master@{#827711}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e4c1a25cc6797a47043fc415c53b8edcd7b3e37e\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"99df1af2aed6a8d10bc62dc348f63d6c084c1949\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32609}\", \"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\": \"38163d72a9d7fa2383c78055cea488f6ed468dc7\", \"swarm_hashes_refs/heads/master(at){#827711}_without_patch\": {\"absl_hardening_tests\": \"3545a3801b0a7c9d6aee4e33719c5f5f001ecd13\", \"accessibility_unittests\": \"8488eb92ce2cd4c6d59ff48e3ffeeeb4a007a768\", \"angle_unittests\": \"2f8055d360268067736d8e6215885514f4cb2c86\", \"app_shell_unittests\": \"08ac7070c16323e218269ebe76c9b07f16b7257c\", \"aura_unittests\": \"0f240a6fe27ecb8168eed4a5f812e4744dc5fd03\", \"base_unittests\": \"c5b3e2718542b3ac536791974b7d1c5d8ea336c3\", \"base_util_unittests\": \"058ddd4df25f509e37b8538ecb142a96107ce3c5\", \"blink_common_unittests\": \"efa10c5ac8b3966b772739a9c02639c68cb80f58\", \"blink_fuzzer_unittests\": \"207fdcbece200b2acb64353ebe66a204d341b273\", \"blink_heap_unittests\": \"99fd4b1a727e3aa0c896ad8689df1da01afd3b87\", \"blink_platform_unittests\": \"43b00da6657821b088017f41a60c75ff6772a08d\", \"blink_unittests\": \"5bbddeabf255fd445945dfe3781a302f9b01abbe\", \"boringssl_crypto_tests\": \"94add36fde0b1dd2349bb3d28fa9252849b1320a\", \"boringssl_ssl_tests\": \"557b0faddf6c51d5db46a4933494bc237650fa2c\", \"browser_switcher_bho_unittests\": \"ae14cacf3a44aa824584c941f051729d1fc1937d\", \"browser_tests\": \"091849291d685b71fe0d295cf75582e3e70c6bd7\", \"capture_unittests\": \"f1bba0a43f2b9d8f23224e3faf84be358c06b0f2\", \"cast_unittests\": \"89a0274672d2d42b2dc469a19c5a0cf462053202\", \"cc_unittests\": \"c9fc9ac9f331c01ad32ba61683a5bbcba734e1c9\", \"chrome_app_unittests\": \"25a3fb71a0630ff3b18757d4530457b63a4abdf1\", \"chrome_cleaner_unittests\": \"2dd26933390fd4cfb0e7116ee3b0630e3a1d55c9\", \"chrome_elf_unittests\": \"a24413784534618da2cb1aac1e4bfbb694884943\", \"chromedriver_unittests\": \"e9274ef17ef1a557a50494589a795749290a6020\", \"components_browsertests\": \"138c00295d9adf26bd3b778904a5d484976fa6f6\", \"components_unittests\": \"a64b18e25343903c0214f64c931e9037bbeb1735\", \"compositor_unittests\": \"45f801ac3d4b216af6951d3488a3d08c733ea1a2\", \"content_browsertests\": \"17547bdcb528dd4f71f4b3aa0f77158cde4cda89\", \"content_unittests\": \"8b886eb942f0cbf336b0c1c6e47c2e5133460543\", \"courgette_unittests\": \"1125b25c77693136842cc820ab99c40f35380e6e\", \"crashpad_tests\": \"5aeb0e8f1c07a5c3badaf509386722a05bf665ff\", \"cronet_tests\": \"4e9a6613504978ac881c54f02ab4ad05138d8a39\", \"cronet_unittests\": \"5c52a663982f312d5cc3be311fe05952c9ccc0bd\", \"crypto_unittests\": \"354e3243fcbc8cb3f83ef450822b5aecb85cf622\", \"delayloads_unittests\": \"6eeaf73bea755c8f21f968e99b98c40d90871b05\", \"device_unittests\": \"773e5dec42c5e9961dbe3bb9c35e5c2bb99e0bd8\", \"display_unittests\": \"53fb15b45c86771d7c731bdc556174b4bc40924d\", \"elevation_service_unittests\": \"8229883cd113ccf7367396702a54711651771360\", \"events_unittests\": \"4a59ee7441ebd14b1ead78c0aaf59184b5b84252\", \"extensions_browsertests\": \"9134b442244830566381ceab00b914fe9a2065b1\", \"extensions_unittests\": \"2b1436d5d84645a2c0b94a900ef0b52c091a1ce8\", \"filesystem_service_unittests\": \"ec13602480728a7b61b83afa6444c6982de4b784\", \"gcm_unit_tests\": \"637613644ea830d3b52cfe59ea95ee1cb2eb1baa\", \"gcp_unittests\": \"9803d66407474ff850de6cedea14284cd197ed74\", \"gfx_unittests\": \"f49fc73effb1c90b0ba299208ba7aea8da7ce828\", \"gin_unittests\": \"5e5807b4cb14bde5e3c8f6c5b38d456880c717f0\", \"google_apis_unittests\": \"ed0181887fa45aee01abc7423a745da127d1bcf8\", \"gpu_unittests\": \"2eb5b88d82bd50509e46ced37296dd1fcb6c14de\", \"gwp_asan_unittests\": \"b8b0189b5c5ae06124f3c9b83e4a18d618cc5459\", \"headless_browsertests\": \"e672cda608da9f23355a59ce56928ef8571c0cde\", \"headless_unittests\": \"fe21150ccd38a942858060a8fe2addbd9b21b5a1\", \"install_static_unittests\": \"fd56b5b5bbceb9ac76784c573375cc857aad538c\", \"installer_util_unittests\": \"0559485b8ed65cbce6e37cd89805250c6793c841\", \"interactive_ui_tests\": \"9b3d5e0d3430fb9444a5811cd545a36354844099\", \"ipc_tests\": \"031295421a3fe0182b440f25db80de9bf0a22a89\", \"jingle_unittests\": \"0cdda63e60e739b90862cc9e3309fae2bba6bf2e\", \"latency_unittests\": \"6cd72f61f6d2990dd29af2f39a6f80118e7cb048\", \"libjingle_xmpp_unittests\": \"5fdbad0fe203fe455d8892c5b8180290c25aa5a6\", \"liburlpattern_unittests\": \"553a8ce77b161e35b1ae0b947d6a4e9ac8faa8dc\", \"media_blink_unittests\": \"7dde4b64e2d7d7ed5f35fda0f1e8ee094f8c9e53\", \"media_unittests\": \"ca938a54d5fb9a457c2658cfceaa00882aa400b3\", \"message_center_unittests\": \"59322ea2ac9b95e51bb9054eb56a08dfa512dfec\", \"midi_unittests\": \"313fdae6e46b3b325ea85e09df8b5ebdbf3fd075\", \"mojo_core_unittests\": \"21aae869f1ac7a25d5325aa055c767db14d4c12f\", \"mojo_unittests\": \"7405a141c5bdd2a48d58a0b29ec0d499722b7be1\", \"nacl_loader_unittests\": \"22c8e111d58c327b12d2bfa2d5256983f75735bc\", \"native_theme_unittests\": \"4ad7f93c958550c39fe7116c84fe1b65a818d967\", \"net_unittests\": \"55aaf63145ab505f7d80d8ff3fc31958886af75c\", \"notification_helper_unittests\": \"3bf96a1afaa73ef10e601eeb23435b6a8da31eb0\", \"pdf_unittests\": \"0348579fc4299200254f431dc7c9badea5870f57\", \"perfetto_unittests\": \"e0f68d014669170b1684d2dccb618f29b55c56bf\", \"ppapi_unittests\": \"fd9295347cb14aa0acee9fa4b1d29a7ecf2de6fd\", \"printing_unittests\": \"3f3e3568be6f646168c51fb22a240dd90bec40c0\", \"remoting_unittests\": \"953f8556b623e284e68e9705a794687a9040df7b\", \"sbox_integration_tests\": \"0e90c2db51d53302560a5b2bea277b78ef10f5aa\", \"sbox_unittests\": \"17394e26765ff02b6e2d236156a567d420bfd550\", \"sbox_validation_tests\": \"197f4fd4c9e9f545573a285d97e492ce4b2b6fac\", \"service_manager_unittests\": \"0c970e3a38385c35df29a960744212d34fc6b7d0\", \"services_unittests\": \"6dfd01be474cc764ac2410b5afff472261ca46c6\", \"setup_unittests\": \"a10ae8cc41d79159969ea9d4e113047cc8ded063\", \"shell_dialogs_unittests\": \"a9ee0a6f9dcd04c31ee532ee22b73cc004c0cdd7\", \"skia_unittests\": \"4dc9d44a90893e2dbe2943e03d5e5a5f0937cfdf\", \"snapshot_unittests\": \"cfa386b61fc2a3a12d0af892e7a1f7364161c7cb\", \"sql_unittests\": \"ade2ee77c78a78e82915fce1921b73da943d7f61\", \"storage_unittests\": \"c34fe75d4f5f2293d0f8d63df12860072f157dbc\", \"sync_integration_tests\": \"88e7fb9ff2f29243a340f48cc2d17c9e2a2474ba\", \"traffic_annotation_auditor_unittests\": \"6bea12f828b159e36918d11f465ddf286462d2c6\", \"ui_base_unittests\": \"cc4e939a45acce590eeb004d9e1baa4eb9591f92\", \"ui_touch_selection_unittests\": \"416c07fce1fbbfcc338286390ce8f0fb1759815b\", \"unit_tests\": \"a48eb285f458093a6773da17c2a2ac0aa41cc6fe\", \"updater_tests\": \"c48a99cc8ec325d28bf714f4a6aba3303ea1bcf3\", \"url_unittests\": \"ac89c3ed54cc2ab9c339ba045d8f4859768e8745\", \"views_unittests\": \"bd8f22a8f993b371398f9ace7afaa61e2e32f1e6\", \"viz_unittests\": \"9e482f532e231b353318674e8275b26ec0b0d582\", \"vr_common_unittests\": \"b1db1f7d75e0b84004c6600a565ce1b0bb5c48b1\", \"vr_pixeltests\": \"ddbad29df2d5a2950d547c375ae6749a88dfc66a\", \"weblayer_browsertests\": \"7cc62e655ea8249682fb6e0a2ef22a021b3104b4\", \"weblayer_unittests\": \"0a594cd269ecea9a1faedd40d098311410f44225\", \"wm_unittests\": \"46db0bc1bd4d39c46d8f237243ed8f833b7e7175\", \"wtf_unittests\": \"d0ba740be48879ca8e5b406877930dcb01da9146\", \"zlib_unittests\": \"e1ed58501a75f2b1d0b44e4130ec00a7ea64e52e\", \"zucchini_unittests\": \"a0d8a48a147ee6f87f13a20d6f10aa107bd374a0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_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-3-n4wf\"], \"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\": [\"5632-2e614e1\"], \"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.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605511889832837",
"status": "COMPLETED",
"status_changed_ts": "1605511890449183",
"tags": [
"build_address:luci.chromium.ci/win-asan/15661",
"builder:win-asan",
"buildset:commit/git/38163d72a9d7fa2383c78055cea488f6ed468dc7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/38163d72a9d7fa2383c78055cea488f6ed468dc7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028922544836368544",
"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/8863492482798207920/+/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:4fe8c8c5cedd2310",
"user_agent:luci-scheduler"
],
"updated_ts": "1605515173529259",
"url": "https://ci.chromium.org/b/8863492482798207920",
"utcnow_ts": "1605515174288444"
}
}
[08:26:14.304] Invocation finished in 54m47.928106936s with status FAILED