[01:06:44.434] New invocation is queued and will start shortly
[01:06:45.697] Starting the invocation (attempt 1)
[01:06:45.772] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:06:45.772] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:06:45.773] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029762120722477840",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e60529fbcd0a0647f488353eac8d4ff880102778\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029762120722477840",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/e60529fbcd0a0647f488353eac8d4ff880102778",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e60529fbcd0a0647f488353eac8d4ff880102778",
"gitiles_ref:refs/heads/master"
]
}
[01:06:46.602] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604711205868199",
"id": "8864332058553711824",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e60529fbcd0a0647f488353eac8d4ff880102778\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604711206467495",
"tags": [
"build_address:luci.chromium.ci/win-asan/15506",
"builder:win-asan",
"buildset:commit/git/e60529fbcd0a0647f488353eac8d4ff880102778",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e60529fbcd0a0647f488353eac8d4ff880102778",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029762120722477840",
"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/8864332058553711824/+/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": "1604711206467613",
"url": "https://ci.chromium.org/b/8864332058553711824",
"utcnow_ts": "1604711206593076"
}
}
[01:06:46.602] Task URL: https://ci.chromium.org/b/8864332058553711824
[01:06:46.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:2:0) after 1m0s
[01:06:48.710] Received PubSub notification, asking Buildbucket for the build status
[01:06:48.794] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:46.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:2:0)
[01:07:46.675] Timer tick, asking Buildbucket for the build status
[01:07:46.750] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:46.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:4:0) after 1m0s
[01:08:46.815] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:4:0)
[01:08:46.815] Timer tick, asking Buildbucket for the build status
[01:08:46.919] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:46.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:5:0) after 1m0s
[01:09:46.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:5:0)
[01:09:46.962] Timer tick, asking Buildbucket for the build status
[01:09:47.161] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:47.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:6:0) after 1m0s
[01:10:47.171] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:6:0)
[01:10:47.171] Timer tick, asking Buildbucket for the build status
[01:10:47.272] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:47.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:7:0) after 1m0s
[01:11:47.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:7:0)
[01:11:47.415] Timer tick, asking Buildbucket for the build status
[01:11:47.571] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:47.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:8:0) after 1m0s
[01:12:47.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:8:0)
[01:12:47.767] Timer tick, asking Buildbucket for the build status
[01:12:47.851] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:47.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:9:0) after 1m0s
[01:13:47.891] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:9:0)
[01:13:47.891] Timer tick, asking Buildbucket for the build status
[01:13:47.966] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:47.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:10:0) after 1m0s
[01:14:48.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:10:0)
[01:14:48.053] Timer tick, asking Buildbucket for the build status
[01:14:48.124] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:48.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:11:0) after 1m0s
[01:15:48.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:11:0)
[01:15:48.178] Timer tick, asking Buildbucket for the build status
[01:15:48.407] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:48.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:12:0) after 1m0s
[01:16:48.458] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:12:0)
[01:16:48.458] Timer tick, asking Buildbucket for the build status
[01:16:48.569] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:48.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:13:0) after 1m0s
[01:17:48.822] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:13:0)
[01:17:48.822] Timer tick, asking Buildbucket for the build status
[01:17:48.976] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:48.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:14:0) after 1m0s
[01:18:49.040] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:14:0)
[01:18:49.040] Timer tick, asking Buildbucket for the build status
[01:18:49.227] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:49.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:15:0) after 1m0s
[01:19:49.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:15:0)
[01:19:49.255] Timer tick, asking Buildbucket for the build status
[01:19:49.911] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:49.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:16:0) after 1m0s
[01:20:50.007] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:16:0)
[01:20:50.007] Timer tick, asking Buildbucket for the build status
[01:20:50.328] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:50.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:17:0) after 1m0s
[01:21:50.335] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:17:0)
[01:21:50.335] Timer tick, asking Buildbucket for the build status
[01:21:50.900] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:50.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:18:0) after 1m0s
[01:22:50.935] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:18:0)
[01:22:50.935] Timer tick, asking Buildbucket for the build status
[01:22:51.378] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:51.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:19:0) after 1m0s
[01:23:51.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:19:0)
[01:23:51.402] Timer tick, asking Buildbucket for the build status
[01:23:51.736] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:51.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:20:0) after 1m0s
[01:24:51.752] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:20:0)
[01:24:51.752] Timer tick, asking Buildbucket for the build status
[01:24:52.043] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:52.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:21:0) after 1m0s
[01:25:52.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:21:0)
[01:25:52.067] Timer tick, asking Buildbucket for the build status
[01:25:52.198] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:52.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:22:0) after 1m0s
[01:26:52.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:22:0)
[01:26:52.325] Timer tick, asking Buildbucket for the build status
[01:26:52.989] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:52.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:23:0) after 1m0s
[01:27:53.103] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:23:0)
[01:27:53.103] Timer tick, asking Buildbucket for the build status
[01:27:53.304] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:53.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:24:0) after 1m0s
[01:28:53.438] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:24:0)
[01:28:53.438] Timer tick, asking Buildbucket for the build status
[01:28:53.623] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:53.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:25:0) after 1m0s
[01:29:53.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:25:0)
[01:29:53.651] Timer tick, asking Buildbucket for the build status
[01:29:53.758] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:53.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:26:0) after 1m0s
[01:30:53.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:26:0)
[01:30:53.762] Timer tick, asking Buildbucket for the build status
[01:30:53.884] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:53.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:27:0) after 1m0s
[01:31:53.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:27:0)
[01:31:53.888] Timer tick, asking Buildbucket for the build status
[01:31:54.037] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:54.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:28:0) after 1m0s
[01:32:54.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:28:0)
[01:32:54.123] Timer tick, asking Buildbucket for the build status
[01:32:54.203] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:54.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:29:0) after 1m0s
[01:33:54.267] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:29:0)
[01:33:54.267] Timer tick, asking Buildbucket for the build status
[01:33:54.575] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:54.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:30:0) after 1m0s
[01:34:54.713] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:30:0)
[01:34:54.713] Timer tick, asking Buildbucket for the build status
[01:34:55.022] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:55.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:31:0) after 1m0s
[01:35:55.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:31:0)
[01:35:55.039] Timer tick, asking Buildbucket for the build status
[01:35:55.188] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:55.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:32:0) after 1m0s
[01:36:55.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:32:0)
[01:36:55.291] Timer tick, asking Buildbucket for the build status
[01:36:55.440] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:55.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:33:0) after 1m0s
[01:37:55.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:33:0)
[01:37:55.527] Timer tick, asking Buildbucket for the build status
[01:37:55.602] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:55.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:34:0) after 1m0s
[01:38:55.671] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:34:0)
[01:38:55.671] Timer tick, asking Buildbucket for the build status
[01:38:56.306] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:56.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:35:0) after 1m0s
[01:39:56.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:35:0)
[01:39:56.328] Timer tick, asking Buildbucket for the build status
[01:39:56.412] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:56.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:36:0) after 1m0s
[01:40:56.518] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:36:0)
[01:40:56.518] Timer tick, asking Buildbucket for the build status
[01:40:56.621] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:56.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:37:0) after 1m0s
[01:41:56.733] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:37:0)
[01:41:56.733] Timer tick, asking Buildbucket for the build status
[01:41:57.113] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:57.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:38:0) after 1m0s
[01:42:57.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:38:0)
[01:42:57.165] Timer tick, asking Buildbucket for the build status
[01:42:57.240] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:57.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:39:0) after 1m0s
[01:43:57.299] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:39:0)
[01:43:57.299] Timer tick, asking Buildbucket for the build status
[01:43:57.383] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:57.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:40:0) after 1m0s
[01:44:57.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:40:0)
[01:44:57.576] Timer tick, asking Buildbucket for the build status
[01:44:59.296] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:59.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:41:0) after 1m0s
[01:45:59.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:41:0)
[01:45:59.333] Timer tick, asking Buildbucket for the build status
[01:45:59.422] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:59.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:42:0) after 1m0s
[01:46:59.464] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:42:0)
[01:46:59.464] Timer tick, asking Buildbucket for the build status
[01:46:59.574] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:59.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:43:0) after 1m0s
[01:47:59.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:43:0)
[01:47:59.659] Timer tick, asking Buildbucket for the build status
[01:47:59.785] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:59.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:44:0) after 1m0s
[01:48:59.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:44:0)
[01:48:59.898] Timer tick, asking Buildbucket for the build status
[01:49:00.205] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:00.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:45:0) after 1m0s
[01:50:00.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:45:0)
[01:50:00.352] Timer tick, asking Buildbucket for the build status
[01:50:00.428] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:00.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:46:0) after 1m0s
[01:51:00.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:46:0)
[01:51:00.605] Timer tick, asking Buildbucket for the build status
[01:51:00.781] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:00.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:47:0) after 1m0s
[01:52:00.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:47:0)
[01:52:00.862] Timer tick, asking Buildbucket for the build status
[01:52:00.971] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:00.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:48:0) after 1m0s
[01:53:01.176] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:48:0)
[01:53:01.176] Timer tick, asking Buildbucket for the build status
[01:53:01.623] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:01.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:49:0) after 1m0s
[01:54:01.661] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:49:0)
[01:54:01.661] Timer tick, asking Buildbucket for the build status
[01:54:02.235] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:02.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:50:0) after 1m0s
[01:55:02.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:50:0)
[01:55:02.342] Timer tick, asking Buildbucket for the build status
[01:55:02.427] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:02.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:51:0) after 1m0s
[01:56:02.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:51:0)
[01:56:02.451] Timer tick, asking Buildbucket for the build status
[01:56:02.539] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:02.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:52:0) after 1m0s
[01:57:02.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:52:0)
[01:57:02.569] Timer tick, asking Buildbucket for the build status
[01:57:02.896] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:02.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:53:0) after 1m0s
[01:58:02.975] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:53:0)
[01:58:02.975] Timer tick, asking Buildbucket for the build status
[01:58:03.442] Build 8864332058553711824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:03.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029762120722477840:54:0) after 1m0s
[01:58:49.121] Received PubSub notification, asking Buildbucket for the build status
[01:58:49.198] Build 8864332058553711824: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:58:49.198] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604714327195574",
"created_by": "project:chromium",
"created_ts": "1604711205868199",
"failure_reason": "BUILD_FAILURE",
"id": "8864332058553711824",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e60529fbcd0a0647f488353eac8d4ff880102778\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** 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\": \"e60529fbcd0a0647f488353eac8d4ff880102778\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-4-h4bf\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15506, \"clang_revision\": \"llvmorg-12-init-10666-gc9f69ee7-1\", \"got_angle_revision\": \"156c227d6cf2e09e2450d01ed45fc281494aa4ed\", \"got_dawn_revision\": \"16036cf206f186a1db2659e717711c72e81c392e\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"e60529fbcd0a0647f488353eac8d4ff880102778\", \"got_revision_cp\": \"refs/heads/master@{#825131}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"a16002b5edb4e0ad297cb7835e984dc9d79fd417\", \"got_v8_revision_cp\": \"refs/heads/8.8.248@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"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\": \"e60529fbcd0a0647f488353eac8d4ff880102778\", \"swarm_hashes_refs/heads/master(at){#825131}_without_patch\": {\"absl_hardening_tests\": \"b35dcf0c11ce88c47fac24018bfea741d83911cd\", \"accessibility_unittests\": \"e49e8d621ce88d53ef5c00544e9d1125effb3bf2\", \"angle_unittests\": \"04dd392a90a3b1cd27d397c2fbe6042f2d63ff34\", \"app_shell_unittests\": \"472116dd263f96476d692a8d6d28d4f9bda69e70\", \"aura_unittests\": \"8bbb6690fdbd91e9412a5f5b64c8cb4300e42515\", \"base_unittests\": \"32ee15f251d0198213930c51da74bd3052179289\", \"base_util_unittests\": \"338c8de2f7708cf39d0a20851af958a1d99665e8\", \"blink_common_unittests\": \"a8416329d7b0fd27b5a619ee7c8a75a68b574c9a\", \"blink_fuzzer_unittests\": \"5f8195cf4aa8181045ea2cbe46b36afb6d558989\", \"blink_heap_unittests\": \"a60c96c8c76e1c6254d13b8591f22da269ccc4c5\", \"blink_platform_unittests\": \"8a98f807ad354d557b768519b905dc5f1a82555b\", \"blink_unittests\": \"4026cc6484ae68803646f14470050849efd859e8\", \"boringssl_crypto_tests\": \"a1d0787802055aa5f7651d6760b0b1abd5ae28b3\", \"boringssl_ssl_tests\": \"8a4200520dab28c39f3b48cddd8c7365874a49d1\", \"browser_switcher_bho_unittests\": \"f6de208d35314884d28a445343fc3bfc5d15d799\", \"browser_tests\": \"26c884e7e899a6d751aa1571a730aecb00f6960c\", \"capture_unittests\": \"c17b10b94ab8622cf55beb566534df2b852ad917\", \"cast_unittests\": \"94d384acae4753504e7170c8f567ad7d973afd23\", \"cc_unittests\": \"5cefe3e2f488b0ef2862fb5e68aabafc2ee72ccd\", \"chrome_app_unittests\": \"1f97b2be8a6c06fb164c2cee37e95dbae029fbec\", \"chrome_cleaner_unittests\": \"de284e599945d15748a3aa7218d7f7f52bdcd19d\", \"chrome_elf_unittests\": \"9b3903be60ec6eb8bb8807d9328f12d93e5437e3\", \"chromedriver_unittests\": \"863027f5a82910131d3d5a646e9b4178a32d30ea\", \"components_browsertests\": \"67514a622c1604c99718d0d07634b50e95d19866\", \"components_unittests\": \"ed124c08994c572575372ab11284d0596995caf1\", \"compositor_unittests\": \"5e00e0fd8a4fa6c90677613a59de55e87fa7c4b8\", \"content_browsertests\": \"a4e15ebfce3977d7f4dbb49fb124337142d7b840\", \"content_unittests\": \"3353b62a6d56cc063b6ae88ac7c01f4cb321bdc8\", \"courgette_unittests\": \"4172c07bfbf90ddc47016a638fdbb4dd2cf4c957\", \"crashpad_tests\": \"76aa98509ab8bd50b3610394c58317e3ba737f4d\", \"cronet_tests\": \"ed2900d19916fb2766a853d2812cb5cc4c9c2f04\", \"cronet_unittests\": \"9310f9b3c9143de5e34f96b8d0640fd0180d6fd0\", \"crypto_unittests\": \"903f177482e231ef90b645fc3019e0eb1c28746e\", \"delayloads_unittests\": \"822fca8e1eb8a6679597cca2f8619e6fc8743f24\", \"device_unittests\": \"8189d84cf578f165745e01db22837eee6773964e\", \"display_unittests\": \"d5c775b6ddccbb7abb873480c3f30fb5304e65c4\", \"elevation_service_unittests\": \"166fc07806aa40fb184d65ae147a09b209f8f54d\", \"events_unittests\": \"e26846e9d8c2cfa0a231fa5669e816d1822a4bbe\", \"extensions_browsertests\": \"2de312f283df6da723337263f5aea6501a1d73ec\", \"extensions_unittests\": \"fc01238ab23db47a04a75d8bbe32ebe6766635f0\", \"filesystem_service_unittests\": \"6939d241b17b13f7cba0594fa70087137ab8cdfc\", \"gcm_unit_tests\": \"eb32a2c42faf51269d2d3cb6a0542b93022775ff\", \"gcp_unittests\": \"7206aac809b403cdb02deb9d842c2e9f264f880a\", \"gfx_unittests\": \"a9f8c31aa421db5982190a2780437afe15a64e79\", \"gin_unittests\": \"69d4018c29a485af8308a797f8d3be1969f7b6f0\", \"google_apis_unittests\": \"ac50d3f8bd3a69d2e95ff6c323182611b3cf102e\", \"gpu_unittests\": \"d8b09e28626f6030789978527cf78738f540b6d8\", \"gwp_asan_unittests\": \"deace411373479484475a099adfe21c2585174e2\", \"headless_browsertests\": \"869b1c0952d5e0e0eb5fea8b99552940c5570422\", \"headless_unittests\": \"7c85fb27d50c1267f7dd6e08d1a93fe11fb0d772\", \"install_static_unittests\": \"4d242696d8f210b59188b6e13421832d8a482c27\", \"installer_util_unittests\": \"352bd710e153e6e7f64618b3da2db69737d3f673\", \"interactive_ui_tests\": \"48ae1d0829131a82388588841bd9e2185c3e4835\", \"ipc_tests\": \"a1beee8cc90ba4987188d5abcdf8807d893782aa\", \"jingle_unittests\": \"ab0c4687ea19d72350173c4a565ae45ea7cb06fb\", \"latency_unittests\": \"bc3ca85dcf51e59b4fd06ec32b855da9a63802c2\", \"libjingle_xmpp_unittests\": \"d51412c32e5ddaead15d513dbd7f87004373d327\", \"liburlpattern_unittests\": \"8b981f2d5aff933f62b8ae936a9ea7fd2f9d5948\", \"media_blink_unittests\": \"2aa1c06a53038f9aacd3d8ba92419d67e8718f9d\", \"media_unittests\": \"39ed78904ac20cbb7d24cff83ded845ea22f0bd4\", \"message_center_unittests\": \"73a79e74128a0ab55b1b236874d67361eddf67bf\", \"midi_unittests\": \"e46c9f9e892d98cdfa5f1b0bee84adb43fbf3b1b\", \"mojo_core_unittests\": \"d676a92a35bbbfa7cb7cf760223cca493b1f0835\", \"mojo_unittests\": \"9783ad1245878e9c91792b288a1b9e9bb4860772\", \"nacl_loader_unittests\": \"3347ceae5a4162402ac346b2a8ecb99908e0543c\", \"native_theme_unittests\": \"1b4db3c58c784684d194c30165d7290b8c380269\", \"net_unittests\": \"a624fc51f55c28d3f2bc28d3fd9cc765f9250f7f\", \"notification_helper_unittests\": \"40921474f9a34c9b4f271971fdb11fd82c6c3e5d\", \"pdf_unittests\": \"67aef7b13d1b00044a3e9b349781d40579eb7326\", \"perfetto_unittests\": \"54c7cd3a6b261fac3fec65ba229064747f69861f\", \"ppapi_unittests\": \"502728f6cc31cc286294cde13c8fecef6a6be552\", \"printing_unittests\": \"c3f476493f285c9a2fbd0715f394591c081b32df\", \"remoting_unittests\": \"ebfdbd411824567b7a74b4734710158fef6d5110\", \"sbox_integration_tests\": \"dff5cc77f94114cd6f2d70e9fffaae9640751594\", \"sbox_unittests\": \"ee95c7726c6b11309c8ed4ab0f5210eeaffc2626\", \"sbox_validation_tests\": \"800090508f02b3f8eb9ca03296791c5e50cd3c5d\", \"service_manager_unittests\": \"a5a145186fafb54376572d5a4d23182a386bb62d\", \"services_unittests\": \"e3d67dec65ab3b9cf4d1e34b0846a1e4f2858768\", \"setup_unittests\": \"a196815b71a65b59a96cc3ba363eeb28e5065935\", \"shell_dialogs_unittests\": \"c5c4e6047661632964c8054f4705de337e7a2f1c\", \"skia_unittests\": \"183449669b8c82c3dd07f4046703c03cbc24d1a7\", \"snapshot_unittests\": \"3a5c27e14b25c2e5e607d96ad47c2ece976509c2\", \"sql_unittests\": \"c452a235956afa0ef3fa6e854e123b6189791e86\", \"storage_unittests\": \"0dfdc6ef879df011d0847463b4b77af1d648fbd5\", \"sync_integration_tests\": \"962882baf8aa5d00c86379fda15d08dda6f2e3e3\", \"traffic_annotation_auditor_unittests\": \"a71b17e67aacded7728f4c6c86fd573ae7a71a7f\", \"ui_base_unittests\": \"208babd05ed774ae0814bcfafebb669dc6c40507\", \"ui_touch_selection_unittests\": \"b02b69f1f4196e450de91b8a0c9959487aed9691\", \"unit_tests\": \"2890b3169a2c2e51aa70cf65c5850598946b94ee\", \"updater_tests\": \"706c3639703a62b984192bcfc4a6c3f0359f492b\", \"url_unittests\": \"c2e9baf1dc3ef669ba2eeaedad9895300b4e5168\", \"views_unittests\": \"68c2b2a3f31187df3c2ea92236dd4db86181369d\", \"viz_unittests\": \"9e714a748cffee650e613c37ef6d94cc13715f74\", \"vr_common_unittests\": \"9daec904385e439261cf134c11e22cd75383f9e1\", \"vr_pixeltests\": \"2f2fe3750b1ff780640eb668cc75ed0d34e71efd\", \"weblayer_browsertests\": \"d46b8795b16829e5ba643bd2e7f08d58e312b9ac\", \"weblayer_unittests\": \"fec3accf66c969213c0edbc4f25645ad1355d88c\", \"wm_unittests\": \"8ed8b8f51cbd4d15e4cce0ca5d1aab53b1d54855\", \"wtf_unittests\": \"fd441ef56796efdd39940fd131f49bd2ad3f0b25\", \"zlib_unittests\": \"3b06adcdbd1b00fe21ff4cb5feb4e70ddfe7fbc6\", \"zucchini_unittests\": \"23abe7982f78dc5e9f4b5b2ea6572e6abe46af1c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_91b2ef8341586e76bd64fa3093e74ce43aef344c2e2134fb3b046b47c3d4bcdb_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-4-h4bf\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604711207940835",
"status": "COMPLETED",
"status_changed_ts": "1604711208415804",
"tags": [
"build_address:luci.chromium.ci/win-asan/15506",
"builder:win-asan",
"buildset:commit/git/e60529fbcd0a0647f488353eac8d4ff880102778",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e60529fbcd0a0647f488353eac8d4ff880102778",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029762120722477840",
"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/8864332058553711824/+/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:4fb90f576963cc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604714328472451",
"url": "https://ci.chromium.org/b/8864332058553711824",
"utcnow_ts": "1604714329185294"
}
}
[01:58:49.199] Invocation finished in 52m4.782932485s with status FAILED