[05:52:31.796] New invocation is queued and will start shortly
[05:52:32.921] Starting the invocation (attempt 1)
[05:52:32.965] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:52:32.966] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:52:32.966] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029562946479024336",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7e54195958dda757f9a514aaaac6699f24ca6cef\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029562946479024336",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/7e54195958dda757f9a514aaaac6699f24ca6cef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7e54195958dda757f9a514aaaac6699f24ca6cef",
"gitiles_ref:refs/heads/master"
]
}
[05:52:33.609] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604901153062229",
"id": "8864132884485539232",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7e54195958dda757f9a514aaaac6699f24ca6cef\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604901153493744",
"tags": [
"build_address:luci.chromium.ci/win-asan/15546",
"builder:win-asan",
"buildset:commit/git/7e54195958dda757f9a514aaaac6699f24ca6cef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7e54195958dda757f9a514aaaac6699f24ca6cef",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029562946479024336",
"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/8864132884485539232/+/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": "1604901153493857",
"url": "https://ci.chromium.org/b/8864132884485539232",
"utcnow_ts": "1604901153600762"
}
}
[05:52:33.609] Task URL: https://ci.chromium.org/b/8864132884485539232
[05:52:33.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:2:0) after 1m0s
[05:52:36.131] Received PubSub notification, asking Buildbucket for the build status
[05:52:36.210] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:33.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:2:0)
[05:53:33.646] Timer tick, asking Buildbucket for the build status
[05:53:33.802] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:33.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:4:0) after 1m0s
[05:54:33.828] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:4:0)
[05:54:33.828] Timer tick, asking Buildbucket for the build status
[05:54:33.947] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:33.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:5:0) after 1m0s
[05:55:34.154] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:5:0)
[05:55:34.154] Timer tick, asking Buildbucket for the build status
[05:55:34.818] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:34.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:6:0) after 1m0s
[05:56:34.847] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:6:0)
[05:56:34.847] Timer tick, asking Buildbucket for the build status
[05:56:34.943] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:34.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:7:0) after 1m0s
[05:57:35.058] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:7:0)
[05:57:35.058] Timer tick, asking Buildbucket for the build status
[05:57:35.265] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:35.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:8:0) after 1m0s
[05:58:35.355] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:8:0)
[05:58:35.355] Timer tick, asking Buildbucket for the build status
[05:58:35.459] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:35.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:9:0) after 1m0s
[05:59:35.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:9:0)
[05:59:35.569] Timer tick, asking Buildbucket for the build status
[05:59:35.638] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:35.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:10:0) after 1m0s
[06:00:35.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:10:0)
[06:00:35.877] Timer tick, asking Buildbucket for the build status
[06:00:36.571] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:36.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:11:0) after 1m0s
[06:01:48.975] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:11:0)
[06:01:48.975] Timer tick, asking Buildbucket for the build status
[06:01:49.135] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:49.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:12:0) after 1m0s
[06:02:49.193] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:12:0)
[06:02:49.193] Timer tick, asking Buildbucket for the build status
[06:02:49.298] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:49.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:13:0) after 1m0s
[06:03:49.386] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:13:0)
[06:03:49.386] Timer tick, asking Buildbucket for the build status
[06:03:49.498] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:49.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:14:0) after 1m0s
[06:04:49.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:14:0)
[06:04:49.526] Timer tick, asking Buildbucket for the build status
[06:04:49.822] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:49.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:15:0) after 1m0s
[06:05:49.871] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:15:0)
[06:05:49.871] Timer tick, asking Buildbucket for the build status
[06:05:49.998] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:49.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:16:0) after 1m0s
[06:06:49.998] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:16:0)
[06:06:49.998] Timer tick, asking Buildbucket for the build status
[06:06:50.632] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:50.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:17:0) after 1m0s
[06:07:50.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:17:0)
[06:07:50.684] Timer tick, asking Buildbucket for the build status
[06:07:51.668] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:51.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:18:0) after 1m0s
[06:08:51.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:18:0)
[06:08:51.703] Timer tick, asking Buildbucket for the build status
[06:08:52.226] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:52.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:19:0) after 1m0s
[06:09:52.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:19:0)
[06:09:52.308] Timer tick, asking Buildbucket for the build status
[06:09:52.749] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:52.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:20:0) after 1m0s
[06:10:52.796] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:20:0)
[06:10:52.796] Timer tick, asking Buildbucket for the build status
[06:10:52.919] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:52.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:21:0) after 1m0s
[06:11:52.959] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:21:0)
[06:11:52.959] Timer tick, asking Buildbucket for the build status
[06:11:53.385] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:53.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:22:0) after 1m0s
[06:12:53.424] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:22:0)
[06:12:53.424] Timer tick, asking Buildbucket for the build status
[06:12:53.839] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:53.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:23:0) after 1m0s
[06:13:53.904] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:23:0)
[06:13:53.904] Timer tick, asking Buildbucket for the build status
[06:13:54.012] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:54.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:24:0) after 1m0s
[06:14:54.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:24:0)
[06:14:54.035] Timer tick, asking Buildbucket for the build status
[06:14:54.113] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:54.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:25:0) after 1m0s
[06:15:54.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:25:0)
[06:15:54.173] Timer tick, asking Buildbucket for the build status
[06:15:54.559] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:54.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:26:0) after 1m0s
[06:16:54.647] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:26:0)
[06:16:54.647] Timer tick, asking Buildbucket for the build status
[06:16:54.725] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:54.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:27:0) after 1m0s
[06:17:54.835] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:27:0)
[06:17:54.835] Timer tick, asking Buildbucket for the build status
[06:17:54.961] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:54.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:28:0) after 1m0s
[06:18:55.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:28:0)
[06:18:55.001] Timer tick, asking Buildbucket for the build status
[06:18:55.588] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:55.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:29:0) after 1m0s
[06:19:55.643] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:29:0)
[06:19:55.644] Timer tick, asking Buildbucket for the build status
[06:19:55.720] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:55.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:30:0) after 1m0s
[06:20:55.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:30:0)
[06:20:55.729] Timer tick, asking Buildbucket for the build status
[06:20:55.829] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:55.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:31:0) after 1m0s
[06:21:55.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:31:0)
[06:21:55.856] Timer tick, asking Buildbucket for the build status
[06:21:55.932] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:55.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:32:0) after 1m0s
[06:22:55.956] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:32:0)
[06:22:55.956] Timer tick, asking Buildbucket for the build status
[06:22:56.130] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:56.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:33:0) after 1m0s
[06:23:56.152] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:33:0)
[06:23:56.152] Timer tick, asking Buildbucket for the build status
[06:23:56.226] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:56.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:34:0) after 1m0s
[06:24:56.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:34:0)
[06:24:56.317] Timer tick, asking Buildbucket for the build status
[06:24:56.444] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:56.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:35:0) after 1m0s
[06:25:56.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:35:0)
[06:25:56.504] Timer tick, asking Buildbucket for the build status
[06:25:57.113] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:57.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:36:0) after 1m0s
[06:26:57.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:36:0)
[06:26:57.167] Timer tick, asking Buildbucket for the build status
[06:26:57.369] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:57.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:37:0) after 1m0s
[06:27:57.390] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:37:0)
[06:27:57.390] Timer tick, asking Buildbucket for the build status
[06:27:57.530] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:57.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:38:0) after 1m0s
[06:28:57.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:38:0)
[06:28:57.547] Timer tick, asking Buildbucket for the build status
[06:28:57.679] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:57.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:39:0) after 1m0s
[06:29:57.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:39:0)
[06:29:57.751] Timer tick, asking Buildbucket for the build status
[06:29:57.850] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:57.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:40:0) after 1m0s
[06:30:57.884] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:40:0)
[06:30:57.884] Timer tick, asking Buildbucket for the build status
[06:30:58.496] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:58.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:41:0) after 1m0s
[06:31:58.521] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:41:0)
[06:31:58.521] Timer tick, asking Buildbucket for the build status
[06:31:58.592] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:58.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:42:0) after 1m0s
[06:32:58.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:42:0)
[06:32:58.626] Timer tick, asking Buildbucket for the build status
[06:32:58.903] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:58.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:43:0) after 1m0s
[06:33:59.061] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:43:0)
[06:33:59.061] Timer tick, asking Buildbucket for the build status
[06:33:59.180] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:59.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:44:0) after 1m0s
[06:34:59.586] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:44:0)
[06:34:59.586] Timer tick, asking Buildbucket for the build status
[06:34:59.969] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:59.969] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:45:0) after 1m0s
[06:36:00.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:45:0)
[06:36:00.112] Timer tick, asking Buildbucket for the build status
[06:36:00.233] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:00.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:46:0) after 1m0s
[06:37:00.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:46:0)
[06:37:00.362] Timer tick, asking Buildbucket for the build status
[06:37:00.688] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:00.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:47:0) after 1m0s
[06:38:00.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:47:0)
[06:38:00.753] Timer tick, asking Buildbucket for the build status
[06:38:01.369] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:01.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:48:0) after 1m0s
[06:39:03.549] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:48:0)
[06:39:03.549] Timer tick, asking Buildbucket for the build status
[06:39:03.627] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:03.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:49:0) after 1m0s
[06:40:03.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:49:0)
[06:40:03.992] Timer tick, asking Buildbucket for the build status
[06:40:04.682] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:04.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:50:0) after 1m0s
[06:41:05.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:50:0)
[06:41:05.286] Timer tick, asking Buildbucket for the build status
[06:41:05.427] Build 8864132884485539232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:05.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029562946479024336:51:0) after 1m0s
[06:41:17.875] Received PubSub notification, asking Buildbucket for the build status
[06:41:18.015] Build 8864132884485539232: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:41:18.015] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604904077238964",
"created_by": "project:chromium",
"created_ts": "1604901153062229",
"id": "8864132884485539232",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7e54195958dda757f9a514aaaac6699f24ca6cef\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"7e54195958dda757f9a514aaaac6699f24ca6cef\", \"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-8-b9eu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15546, \"clang_revision\": \"llvmorg-12-init-10666-gc9f69ee7-1\", \"got_angle_revision\": \"d4439824c55428a699aa543a2f397d06a00841b6\", \"got_dawn_revision\": \"3e17e33724b4d0b4c4fc1985340882e1f543e3a0\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"7e54195958dda757f9a514aaaac6699f24ca6cef\", \"got_revision_cp\": \"refs/heads/master@{#825255}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"4075f123295bb39d50e472b7af1fc04d4f4fe228\", \"got_v8_revision_cp\": \"refs/heads/8.8.250@{#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\": \"7e54195958dda757f9a514aaaac6699f24ca6cef\", \"swarm_hashes_refs/heads/master(at){#825255}_without_patch\": {\"absl_hardening_tests\": \"5c6242604e6559ea3fa4749103b22d41f09b24d5\", \"accessibility_unittests\": \"6f069456f5dd1cc53ee6fe0eb73920ff0b9af969\", \"angle_unittests\": \"29fbd0146a40c67e8dce25a78dce2a10b2c67cf1\", \"app_shell_unittests\": \"d338bd5e852f05815187939cbb8970b5e03f09a6\", \"aura_unittests\": \"d0c8184ca01a357cef9b247dfc6f3ee62442fb81\", \"base_unittests\": \"745e5bd5e236ac1f16e148a951102592e8023748\", \"base_util_unittests\": \"4ad036e66c30a29e3875903603dc334408ad4bc3\", \"blink_common_unittests\": \"450bf7b3b6d356ab66c02be519e83043b31c0ffe\", \"blink_fuzzer_unittests\": \"282f0830482fb3ab3a81c3afa110863f41a50ba6\", \"blink_heap_unittests\": \"6eff82ca62371f0e5d249f2d55ef56096cec1420\", \"blink_platform_unittests\": \"78218896e2620e393e57124aca580b22b1113256\", \"blink_unittests\": \"b8d9284a2972825aa185430af05408c11756568b\", \"boringssl_crypto_tests\": \"1de0bb1c60aea0bc27c2af2374a6fb48404be5fb\", \"boringssl_ssl_tests\": \"fac48afbe8cb9a81d57042b3d5acd1e78ac982d5\", \"browser_switcher_bho_unittests\": \"7b654a6ea41eceae7dc18589b206a6ab371e287f\", \"browser_tests\": \"4d9c8308c5fb2a9d08873daaa868f91412b5fbed\", \"capture_unittests\": \"1aa516b43f8d0cab483c6b08bde88deb1a2aadde\", \"cast_unittests\": \"cc64f2d86daf424bc1507218f3703eae03c11fe8\", \"cc_unittests\": \"9deae1817a00526388f97d9c03246e82bb1325b7\", \"chrome_app_unittests\": \"946b659dcf7ae4bcb7a374adad4dd2ee19428446\", \"chrome_cleaner_unittests\": \"9583caaa69cabe73ea764ce4efdccae965f4206b\", \"chrome_elf_unittests\": \"d59458f53c60aeadbef6e7e4bc03c56ea52dcf17\", \"chromedriver_unittests\": \"062474b976d17d721ca4e67f0ae4528d43101103\", \"components_browsertests\": \"84fe37cd48e45b39a32eaf87c3eb6bb4dc2aecb1\", \"components_unittests\": \"b6611b770e7e75fa560dc659ead4c700f1ca850c\", \"compositor_unittests\": \"b9a24e96c0a94e213ad24d9069aace2072eb02cc\", \"content_browsertests\": \"28f87d3c6aecd441c630e101948b9f29880bb5dc\", \"content_unittests\": \"240c4dd35b351f9625044e0273d2b58bde9bdf04\", \"courgette_unittests\": \"36e948bb2c127c434a39d7bae21733bcb0bd5da7\", \"crashpad_tests\": \"2f9cc54e27313d23e43e0fed8edfc0a76b7ee162\", \"cronet_tests\": \"b1de4c412bc135bdc52ed74b39b4e2d09936bc25\", \"cronet_unittests\": \"8ad2be71d08c7a6219ac1bca8286d395721367f6\", \"crypto_unittests\": \"b0726cd112d95272d690b202eca3553ff2d61f10\", \"delayloads_unittests\": \"3454806e568ddacd26eb25e5477c2139eea349e5\", \"device_unittests\": \"73caa07a4cf5284e0c1ec65ae306a433c1a461f0\", \"display_unittests\": \"401fd88040731a349128bdc214833fd17fcbbaa0\", \"elevation_service_unittests\": \"65436cc98baa0da2729ce6cc21b40e29b0428cef\", \"events_unittests\": \"f43d77095e3662121d31ce3e2590d749b8da3d7f\", \"extensions_browsertests\": \"c267258fbb5cb6fdc95f24271e513f07db88c874\", \"extensions_unittests\": \"83f407195378a2a60f7caaddd65d493a2a03b3a7\", \"filesystem_service_unittests\": \"7f49e3cc5fd8430d10755434cdf0c5f9e4978ac3\", \"gcm_unit_tests\": \"8ba8bc99456aa8857b943264b4cfb450ebb3632c\", \"gcp_unittests\": \"88d87cfad200ddffc4b21a7a0077f7e1d25c2f36\", \"gfx_unittests\": \"32e8c24f3341d3d26f184c318c223e09c9d92ca5\", \"gin_unittests\": \"a1d6f5e5c23d9b0a34197b68aee19ac26d80fe2a\", \"google_apis_unittests\": \"29bd400e480d7985f6bdda3582b9b632ef9fdd1c\", \"gpu_unittests\": \"fb644e236d9778cf10eefc5bc2f9ae445f6b9766\", \"gwp_asan_unittests\": \"450399906ce921da879b47db1b2f9e09936736ec\", \"headless_browsertests\": \"b7efa86db22e66dccc001e960bde72874dd08aca\", \"headless_unittests\": \"ab080e780c83caf066c382f4559a75ed75736bc9\", \"install_static_unittests\": \"f2490dcee7ab54108c3b58470fb268f86676597e\", \"installer_util_unittests\": \"ac0cbe10eda7fa25c8a354762c1b7d8bdfb4c315\", \"interactive_ui_tests\": \"99f9d0d3a6c444e20170ea8ae68cf1cac5bed6dc\", \"ipc_tests\": \"18f438cf24f6307b9d02d718a4973c2aec543e8e\", \"jingle_unittests\": \"59ba644e3c1080eeeeb0e754414b84ebea1bd8e5\", \"latency_unittests\": \"c7ea2d1ce82cbb1025950912b0bc5766d41f1b86\", \"libjingle_xmpp_unittests\": \"71977fe5520c42ac7e5b8d386ddcebc06cb17876\", \"liburlpattern_unittests\": \"463d7a1a63e0d9fac6b2371a549fc10d9945fa9e\", \"media_blink_unittests\": \"3a1cfe46c5d0a68cd372f19f1ef43614ec66a1cc\", \"media_unittests\": \"090ae6a1a589ec605d3a1998c8706e3f2a19af7a\", \"message_center_unittests\": \"127a05c42c7c01781db38891060d9cab0e1fb0fa\", \"midi_unittests\": \"db90299fc42ab9f6a61271fcb8199ba519c0847b\", \"mojo_core_unittests\": \"c7a607b8515865c2361d6ebe37c69a1ccaa662d6\", \"mojo_unittests\": \"c57d17c6ce44ae7f5589b7acf1885b698294a43a\", \"nacl_loader_unittests\": \"d9c765e59df5c9ab546373874e2113079fb23336\", \"native_theme_unittests\": \"5f51251053eb21a375dac2e0f2432c49d68c1693\", \"net_unittests\": \"484ffd46db92fb32a68d4397b114f59afbe6b245\", \"notification_helper_unittests\": \"0800133a1c2759e874d1a5d5c298f24e70fb19da\", \"pdf_unittests\": \"ce3ae4bdb764e08085de4effc7a3e337c36d8fd6\", \"perfetto_unittests\": \"b83d1cc0b371105d107873645d34bbb11a917a98\", \"ppapi_unittests\": \"b93f6618d92130571929cf0e51cc298b49a67055\", \"printing_unittests\": \"ed5981feb0b50a6126b5e50cab421d07c5fecb01\", \"remoting_unittests\": \"6017525cc13be10146d4e0e21b307b6087ba1545\", \"sbox_integration_tests\": \"ff221ec3ec3a516fe97d7143d471c78d0bec9676\", \"sbox_unittests\": \"0fed2aea246ccd96a044af483fbda94c32bd1f50\", \"sbox_validation_tests\": \"0c2c8ab28e34559ca695d67a5f23676cfa7be2b8\", \"service_manager_unittests\": \"cf830b559576aeb7cf976fc82a0c4d0d67e8fe34\", \"services_unittests\": \"f0a85518e3a1832887e2c394db3f1a5fe60b96e5\", \"setup_unittests\": \"7ff777984e3a124904f4cf8536766a2fd366b6c7\", \"shell_dialogs_unittests\": \"8208331e749b7066827d4f8e6b7e40226de277bf\", \"skia_unittests\": \"f8628a8bc7336868ec4eb98610fd843128dc8d99\", \"snapshot_unittests\": \"0b1f5bf306cce3585d981f416afcb7e204d38901\", \"sql_unittests\": \"a1c9685d2cf5de0d299e01bd3f9fc800437d1c29\", \"storage_unittests\": \"04666cfc3950a75354aeaf8e99f99901d1ee8e73\", \"sync_integration_tests\": \"9b2ac5339b6e29b2479900e7a63af8c967ceb52f\", \"traffic_annotation_auditor_unittests\": \"c99769fdd111302b7dc8742343231c0cffaa458e\", \"ui_base_unittests\": \"0f78d2cf7f2fb891720dd1e3690ca2d5929ffbff\", \"ui_touch_selection_unittests\": \"d58e951e90a15ed142750747f53c41e6d827d192\", \"unit_tests\": \"7f18e7a83b01dd5f48921214a2d8e026682875e5\", \"updater_tests\": \"895f5e7e90a03ff1d16d9117ddc949cceb94d94b\", \"url_unittests\": \"cac099bb57b889ab143e84b215d3655d686e1ece\", \"views_unittests\": \"c318d20044033f0a6a1f24db7a22d07d7be3d32b\", \"viz_unittests\": \"40d0f3861c55cbfe90ffc92dcf71771b6589ee5c\", \"vr_common_unittests\": \"d74afef208fbcdfe37b4654d47e91e30859b2e8d\", \"vr_pixeltests\": \"537aef8d7e974a2152a78bc573b7bd581ae8dbf9\", \"weblayer_browsertests\": \"6201d30e750ee51ab4353e25e4c880f2a2c570de\", \"weblayer_unittests\": \"dd7349db82920fde35ad0513c2a9cdeae8dbfd70\", \"wm_unittests\": \"77bd4db3df113409f6b7e9fd1504e0a18c624828\", \"wtf_unittests\": \"35da222003782918372c555974172ceb59c1fbb0\", \"zlib_unittests\": \"bc7f273c31debe9eb6780e640a2fbb01b16af2c3\", \"zucchini_unittests\": \"5de14c85af81babf49e0bce99fe4377d874c60df\"}}, \"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-8-b9eu\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604901155347981",
"status": "COMPLETED",
"status_changed_ts": "1604904077502056",
"tags": [
"build_address:luci.chromium.ci/win-asan/15546",
"builder:win-asan",
"buildset:commit/git/7e54195958dda757f9a514aaaac6699f24ca6cef",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7e54195958dda757f9a514aaaac6699f24ca6cef",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029562946479024336",
"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/8864132884485539232/+/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:4fc461b43512f210",
"user_agent:luci-scheduler"
],
"updated_ts": "1604904077508505",
"url": "https://ci.chromium.org/b/8864132884485539232",
"utcnow_ts": "1604904078003107"
}
}
[06:41:18.015] Invocation finished in 48m46.238234097s with status SUCCEEDED