[10:16:49.038] New invocation is queued and will start shortly
[10:16:50.128] Starting the invocation (attempt 1)
[10:16:50.173] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:16:50.173] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:16:50.173] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028730946255016480",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"15cdafe9a819401befdbf450bc0921fcfd02705b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028730946255016480",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/15cdafe9a819401befdbf450bc0921fcfd02705b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/15cdafe9a819401befdbf450bc0921fcfd02705b",
"gitiles_ref:refs/heads/master"
]
}
[10:16:51.249] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605694610322494",
"id": "8863300884245181536",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"15cdafe9a819401befdbf450bc0921fcfd02705b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605694611113659",
"tags": [
"build_address:luci.chromium.ci/win-asan/15702",
"builder:win-asan",
"buildset:commit/git/15cdafe9a819401befdbf450bc0921fcfd02705b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/15cdafe9a819401befdbf450bc0921fcfd02705b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028730946255016480",
"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/8863300884245181536/+/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": "1605694611113773",
"url": "https://ci.chromium.org/b/8863300884245181536",
"utcnow_ts": "1605694611237713"
}
}
[10:16:51.249] Task URL: https://ci.chromium.org/b/8863300884245181536
[10:16:51.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:2:0) after 1m0s
[10:16:54.249] Received PubSub notification, asking Buildbucket for the build status
[10:16:54.471] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:51.274] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:2:0)
[10:17:51.274] Timer tick, asking Buildbucket for the build status
[10:17:51.426] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:51.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:4:0) after 1m0s
[10:18:51.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:4:0)
[10:18:51.454] Timer tick, asking Buildbucket for the build status
[10:18:51.555] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:51.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:5:0) after 1m0s
[10:19:51.597] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:5:0)
[10:19:51.597] Timer tick, asking Buildbucket for the build status
[10:19:51.801] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:51.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:6:0) after 1m0s
[10:20:51.838] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:6:0)
[10:20:51.838] Timer tick, asking Buildbucket for the build status
[10:20:51.977] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:51.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:7:0) after 1m0s
[10:21:52.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:7:0)
[10:21:52.362] Timer tick, asking Buildbucket for the build status
[10:21:52.962] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:52.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:8:0) after 1m0s
[10:22:53.074] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:8:0)
[10:22:53.074] Timer tick, asking Buildbucket for the build status
[10:22:53.322] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:53.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:9:0) after 1m0s
[10:23:53.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:9:0)
[10:23:53.444] Timer tick, asking Buildbucket for the build status
[10:23:53.589] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:53.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:10:0) after 1m0s
[10:24:53.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:10:0)
[10:24:53.646] Timer tick, asking Buildbucket for the build status
[10:24:54.945] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:54.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:11:0) after 1m0s
[10:25:54.990] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:11:0)
[10:25:54.990] Timer tick, asking Buildbucket for the build status
[10:25:55.043] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:55.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:12:0) after 1m0s
[10:26:55.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:12:0)
[10:26:55.055] Timer tick, asking Buildbucket for the build status
[10:26:55.874] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:55.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:13:0) after 1m0s
[10:27:55.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:13:0)
[10:27:55.900] Timer tick, asking Buildbucket for the build status
[10:27:56.049] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:56.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:14:0) after 1m0s
[10:28:56.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:14:0)
[10:28:56.292] Timer tick, asking Buildbucket for the build status
[10:28:56.519] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:56.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:15:0) after 1m0s
[10:29:56.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:15:0)
[10:29:56.577] Timer tick, asking Buildbucket for the build status
[10:29:56.814] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:56.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:16:0) after 1m0s
[10:30:56.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:16:0)
[10:30:56.880] Timer tick, asking Buildbucket for the build status
[10:30:57.499] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:57.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:17:0) after 1m0s
[10:31:57.603] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:17:0)
[10:31:57.603] Timer tick, asking Buildbucket for the build status
[10:31:58.213] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:58.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:18:0) after 1m0s
[10:32:58.334] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:18:0)
[10:32:58.334] Timer tick, asking Buildbucket for the build status
[10:32:58.503] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:58.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:19:0) after 1m0s
[10:33:58.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:19:0)
[10:33:58.504] Timer tick, asking Buildbucket for the build status
[10:33:58.621] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:58.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:20:0) after 1m0s
[10:34:58.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:20:0)
[10:34:58.655] Timer tick, asking Buildbucket for the build status
[10:34:58.774] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:58.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:21:0) after 1m0s
[10:35:58.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:21:0)
[10:35:58.878] Timer tick, asking Buildbucket for the build status
[10:35:59.666] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:59.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:22:0) after 1m0s
[10:36:59.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:22:0)
[10:36:59.693] Timer tick, asking Buildbucket for the build status
[10:36:59.812] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:59.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:23:0) after 1m0s
[10:37:59.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:23:0)
[10:37:59.860] Timer tick, asking Buildbucket for the build status
[10:38:00.173] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:00.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:24:0) after 1m0s
[10:39:00.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:24:0)
[10:39:00.211] Timer tick, asking Buildbucket for the build status
[10:39:00.383] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:00.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:25:0) after 1m0s
[10:40:00.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:25:0)
[10:40:00.413] Timer tick, asking Buildbucket for the build status
[10:40:00.534] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:00.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:26:0) after 1m0s
[10:41:00.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:26:0)
[10:41:00.579] Timer tick, asking Buildbucket for the build status
[10:41:01.007] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:01.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:27:0) after 1m0s
[10:42:01.034] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:27:0)
[10:42:01.034] Timer tick, asking Buildbucket for the build status
[10:42:01.491] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:01.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:28:0) after 1m0s
[10:43:01.578] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:28:0)
[10:43:01.578] Timer tick, asking Buildbucket for the build status
[10:43:01.717] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:01.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:29:0) after 1m0s
[10:44:01.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:29:0)
[10:44:01.728] Timer tick, asking Buildbucket for the build status
[10:44:02.118] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:02.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:30:0) after 1m0s
[10:45:02.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:30:0)
[10:45:02.212] Timer tick, asking Buildbucket for the build status
[10:45:02.455] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:02.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:31:0) after 1m0s
[10:46:02.521] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:31:0)
[10:46:02.521] Timer tick, asking Buildbucket for the build status
[10:46:03.138] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:03.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:32:0) after 1m0s
[10:47:03.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:32:0)
[10:47:03.205] Timer tick, asking Buildbucket for the build status
[10:47:03.586] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:03.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:33:0) after 1m0s
[10:48:03.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:33:0)
[10:48:03.765] Timer tick, asking Buildbucket for the build status
[10:48:03.878] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:03.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:34:0) after 1m0s
[10:49:04.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:34:0)
[10:49:04.003] Timer tick, asking Buildbucket for the build status
[10:49:05.382] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:05.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:35:0) after 1m0s
[10:50:05.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:35:0)
[10:50:05.392] Timer tick, asking Buildbucket for the build status
[10:50:05.525] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:05.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:36:0) after 1m0s
[10:51:05.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:36:0)
[10:51:05.901] Timer tick, asking Buildbucket for the build status
[10:51:06.013] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:06.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:37:0) after 1m0s
[10:52:06.103] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:37:0)
[10:52:06.103] Timer tick, asking Buildbucket for the build status
[10:52:06.714] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:06.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:38:0) after 1m0s
[10:53:06.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:38:0)
[10:53:06.743] Timer tick, asking Buildbucket for the build status
[10:53:07.127] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:07.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:39:0) after 1m0s
[10:54:07.198] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:39:0)
[10:54:07.198] Timer tick, asking Buildbucket for the build status
[10:54:07.483] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:07.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:40:0) after 1m0s
[10:55:07.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:40:0)
[10:55:07.513] Timer tick, asking Buildbucket for the build status
[10:55:07.614] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:07.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:41:0) after 1m0s
[10:56:07.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:41:0)
[10:56:07.666] Timer tick, asking Buildbucket for the build status
[10:56:07.814] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:07.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:42:0) after 1m0s
[10:57:07.810] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:42:0)
[10:57:07.810] Timer tick, asking Buildbucket for the build status
[10:57:08.524] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:08.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:43:0) after 1m0s
[10:58:08.640] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:43:0)
[10:58:08.640] Timer tick, asking Buildbucket for the build status
[10:58:09.237] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:09.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:44:0) after 1m0s
[10:59:09.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:44:0)
[10:59:09.260] Timer tick, asking Buildbucket for the build status
[10:59:09.341] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:09.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:45:0) after 1m0s
[11:00:09.411] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:45:0)
[11:00:09.412] Timer tick, asking Buildbucket for the build status
[11:00:09.549] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:09.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:46:0) after 1m0s
[11:01:09.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:46:0)
[11:01:09.534] Timer tick, asking Buildbucket for the build status
[11:01:09.653] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:09.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:47:0) after 1m0s
[11:02:09.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:47:0)
[11:02:09.694] Timer tick, asking Buildbucket for the build status
[11:02:09.909] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:09.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:48:0) after 1m0s
[11:03:09.970] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:48:0)
[11:03:09.970] Timer tick, asking Buildbucket for the build status
[11:03:10.401] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:10.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:49:0) after 1m0s
[11:04:10.456] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:49:0)
[11:04:10.456] Timer tick, asking Buildbucket for the build status
[11:04:10.563] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:10.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:50:0) after 1m0s
[11:05:10.598] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:50:0)
[11:05:10.598] Timer tick, asking Buildbucket for the build status
[11:05:10.836] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:10.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:51:0) after 1m0s
[11:06:10.937] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:51:0)
[11:06:10.937] Timer tick, asking Buildbucket for the build status
[11:06:11.002] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:11.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:52:0) after 1m0s
[11:07:11.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:52:0)
[11:07:11.025] Timer tick, asking Buildbucket for the build status
[11:07:11.161] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:11.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:53:0) after 1m0s
[11:08:11.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:53:0)
[11:08:11.215] Timer tick, asking Buildbucket for the build status
[11:08:11.460] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:11.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:54:0) after 1m0s
[11:09:11.499] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:54:0)
[11:09:11.499] Timer tick, asking Buildbucket for the build status
[11:09:11.772] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:11.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:55:0) after 1m0s
[11:10:11.801] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:55:0)
[11:10:11.801] Timer tick, asking Buildbucket for the build status
[11:10:11.912] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:11.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:56:0) after 1m0s
[11:11:12.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:56:0)
[11:11:12.001] Timer tick, asking Buildbucket for the build status
[11:11:12.372] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:12.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:57:0) after 1m0s
[11:12:12.482] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:57:0)
[11:12:12.482] Timer tick, asking Buildbucket for the build status
[11:12:12.717] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:12.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:58:0) after 1m0s
[11:13:12.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:58:0)
[11:13:12.775] Timer tick, asking Buildbucket for the build status
[11:13:12.961] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:12.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:59:0) after 1m0s
[11:14:13.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:59:0)
[11:14:13.005] Timer tick, asking Buildbucket for the build status
[11:14:13.086] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:13.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:60:0) after 1m0s
[11:15:13.149] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:60:0)
[11:15:13.149] Timer tick, asking Buildbucket for the build status
[11:15:13.304] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:13.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:61:0) after 1m0s
[11:16:13.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:61:0)
[11:16:13.366] Timer tick, asking Buildbucket for the build status
[11:16:13.440] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:13.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:62:0) after 1m0s
[11:17:13.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:62:0)
[11:17:13.485] Timer tick, asking Buildbucket for the build status
[11:17:13.607] Build 8863300884245181536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:13.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028730946255016480:63:0) after 1m0s
[11:18:07.666] Received PubSub notification, asking Buildbucket for the build status
[11:18:07.898] Build 8863300884245181536: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:18:07.898] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605698286375614",
"created_by": "project:chromium",
"created_ts": "1605694610322494",
"id": "8863300884245181536",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"15cdafe9a819401befdbf450bc0921fcfd02705b\"}}",
"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\": \"15cdafe9a819401befdbf450bc0921fcfd02705b\", \"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-6zek\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15702, \"clang_revision\": \"llvmorg-12-init-11780-g6ef07111-1\", \"got_angle_revision\": \"2ffff6d024c7d639ecf4258402c2d047bb09588a\", \"got_dawn_revision\": \"a0758a1aef12b02216c2df2781d8e1458d6d7da6\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"15cdafe9a819401befdbf450bc0921fcfd02705b\", \"got_revision_cp\": \"refs/heads/master@{#828656}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"bb96f79d0e15daa9af7b11b2868baeb052d136d9\", \"got_v8_revision\": \"3644d1fc3b7f59e11f5e80b6feb79634736e0192\", \"got_v8_revision_cp\": \"refs/heads/8.9.7@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"15cdafe9a819401befdbf450bc0921fcfd02705b\", \"swarm_hashes_refs/heads/master(at){#828656}_without_patch\": {\"absl_hardening_tests\": \"0679ea15f949ffcc7ee0a58a17b819019893db87\", \"accessibility_unittests\": \"406cdf16bc6817554a4930ff57827204969f33fc\", \"angle_unittests\": \"313f7a1eec76b915a5b487c47573f6326e7885e5\", \"app_shell_unittests\": \"c17fa2cced6d6de4bf616d0a76c22701c47fcf8e\", \"aura_unittests\": \"592b98bee05b75128eedbd5616022c6629a57353\", \"base_unittests\": \"8db472ee8971aa54d81cd9d0df26a557d0d630e8\", \"base_util_unittests\": \"97974c8642e4c8d9c09e602bfb810832a480c288\", \"blink_common_unittests\": \"875f7b65d29ba37ea44381f673ed881d094a1d68\", \"blink_fuzzer_unittests\": \"e6178a3273235db4a255d8e81f8b4ee91f702fe6\", \"blink_heap_unittests\": \"d5b17fdd5368663965bc4d4ca226a77e6bd1f711\", \"blink_platform_unittests\": \"200303bdf9fe711b7821ddaa8e08cfaaa526e02d\", \"blink_unittests\": \"19a584169ee414feda9d1e49e1316cf7095ed95e\", \"boringssl_crypto_tests\": \"2153e80236515e586923df1672e4662c1993362d\", \"boringssl_ssl_tests\": \"eb4ada3deb97bcd98cd1971a5a9937e1f618f5fb\", \"browser_switcher_bho_unittests\": \"e1404b439c6bfb0c4ba4b6ba15da5fab9728ae09\", \"browser_tests\": \"7d223345dc6121efaf81090700d895f4b722375b\", \"capture_unittests\": \"60691be3d273554b113bc7cc8581e280144ab7f1\", \"cast_unittests\": \"583943cdcc89b23b9406291bae6255357aeb6144\", \"cc_unittests\": \"2a1d3528a879e27041fde6f55d7f95c5f0736b58\", \"chrome_app_unittests\": \"4d822cbfad63d405aa356ba4887a987fcc33fcf6\", \"chrome_cleaner_unittests\": \"86f3b775825e6ae16928fd7fe0fc79749d5f18ee\", \"chrome_elf_unittests\": \"60edb556d73ffe6d42c0aa33ed24b7030cefd608\", \"chromedriver_unittests\": \"efb2cd3f6235155a17489e95b42ad52b9557455a\", \"components_browsertests\": \"f73f63936d70d61e08482aac8eeb01cc7e200523\", \"components_unittests\": \"32060adf00933341b56792f017e9ac393e8d124c\", \"compositor_unittests\": \"afc175a3fec474a18c520b2afdae0f81ff2ca640\", \"content_browsertests\": \"06ec1c0335d1455516cfcce8e2ca1490c5c5f923\", \"content_unittests\": \"9645c99ec52b7e2e03c9d46860ab22b1eb201599\", \"courgette_unittests\": \"c288fc7c61166927e19f959000629d4d7fd30ed1\", \"crashpad_tests\": \"3f593d2091d3f090e9f5ffc81722354dadc99870\", \"cronet_tests\": \"fd4b54768ef283410acd12ba2e352cecfa736bf8\", \"cronet_unittests\": \"cf53cfcd814739b9e25d0072d4ada89ebc04f8e2\", \"crypto_unittests\": \"74aabeb4e8a5d82b5c9362be755f21a3f8d93ef8\", \"delayloads_unittests\": \"89d0c78c0908d8317101a687ea9b699a8ed1dc0b\", \"device_unittests\": \"69cfb97814fb16768853a1f6785a58232ab99abf\", \"display_unittests\": \"d85aa2c7bb6ee8acb18cebef97060861e965de5c\", \"elevation_service_unittests\": \"d1c215afdd642fb1df61262482f137d6d111c7f6\", \"events_unittests\": \"a21c3f30d3524f706e0393e5682166bb5e80b089\", \"extensions_browsertests\": \"333c9a4548f860dcaf57fa2fe2b63c43f2705816\", \"extensions_unittests\": \"8cfc572990828db5c7006040ab6a88cc9dc42efb\", \"filesystem_service_unittests\": \"0bb922fdfa67158fb42e845e7b6363ef5edcde9f\", \"gcm_unit_tests\": \"9d6369e69caf8b316e8becfa36ae131094c888a8\", \"gcp_unittests\": \"b0612d57bafe464d1a4da38448c7020e30671cba\", \"gfx_unittests\": \"af99ccb61e4aaa6c119671a4858a00099b61ba33\", \"gin_unittests\": \"9c82d02389644f25500ac3d446e799f39e674336\", \"google_apis_unittests\": \"92fe3c00dbffce1333c41a9e68c872f042c25cff\", \"gpu_unittests\": \"1f287c268eea2663d3cab835817c07b019a72bb3\", \"gwp_asan_unittests\": \"b6e4063b14de943ae58fc9c60caa442bc8b32019\", \"headless_browsertests\": \"6a4c9a44db6902170d6d8537695bed8156aa63ee\", \"headless_unittests\": \"adb304e8501d12c306f7f378b41efedc3ed570f3\", \"install_static_unittests\": \"06db233e86a25baeb1c7ea71a4629acbdf5bed7f\", \"installer_util_unittests\": \"f49ffaf8c7b91c3bf0876905eaf504db9e3d7103\", \"interactive_ui_tests\": \"e9d77becf7a353eac99bde95486c9e446079e4cc\", \"ipc_tests\": \"38f3f26dff5b94b8b30566dcc80a707a743bb3eb\", \"jingle_unittests\": \"8263bd5730370444a7667eadb5845d17e3043fc9\", \"latency_unittests\": \"3f953729bb05952ecdd2c3e445b8b31e42380d38\", \"libjingle_xmpp_unittests\": \"e48970b837fc5215012645b5424fdcd291dfbc67\", \"liburlpattern_unittests\": \"88274f659abb36b98f8d60464addc7e4e2cc4f78\", \"media_blink_unittests\": \"0eb46bc5543e5c88873b0efdd8a5f6154e8e72f1\", \"media_unittests\": \"c741d5aa5c8187604c15503f90306b670f0622a4\", \"message_center_unittests\": \"61ba744634df3e113c015e5201fc489444347228\", \"midi_unittests\": \"61264388c070582539e21f120d15a5f160d86449\", \"mojo_core_unittests\": \"5b1e1b33f2d8c7a5e4a129cffcf12bb5d76e685f\", \"mojo_unittests\": \"b0cdfc28c19552939a39178303c8c78d474fca81\", \"nacl_loader_unittests\": \"480349ba8dfbfb6c4595f9ad1cb956575c318012\", \"native_theme_unittests\": \"89e1b5e18303b3b7b195c4853ed3468a6d210872\", \"net_unittests\": \"a02d07dd15ec9ae8a090a47397987cbee4532def\", \"notification_helper_unittests\": \"5e2653ef749fafb7a087324e7c9efd908a19d2cd\", \"pdf_unittests\": \"0508a0598596397650ed7aab047a567848169b72\", \"perfetto_unittests\": \"dad0618bcb4ba9ba877af241aad27f3d1c51bba4\", \"ppapi_unittests\": \"41f1213fe6a20dd40a5349e7ddd03a7cf3c1dc93\", \"printing_unittests\": \"46340ca969f59919a7e890b61af1de5e548b749d\", \"remoting_unittests\": \"c33c22dc269af56f6a78b073363acddb8f5504e8\", \"sbox_integration_tests\": \"1ebb7ca5a032d1cd0fceb4e5d5e10329697f8053\", \"sbox_unittests\": \"e50c11df3098a873aa69218b1e518d800165864e\", \"sbox_validation_tests\": \"927cc55ff0c14b238069e83c2b212405e2ee3cd3\", \"service_manager_unittests\": \"72457b75841fbbf247306e8dbdbe200eba465887\", \"services_unittests\": \"6fe1bec1a3efb5da071f853c6348e6989b85132a\", \"setup_unittests\": \"ef05d39357933365bb0ca0a31f3d0204af56e5c3\", \"shell_dialogs_unittests\": \"75f742e2fdfe8aa2f81ab7b78341283a16ffe03c\", \"skia_unittests\": \"ba2d279e4fc1bfec172eada46019cda471f2e24b\", \"snapshot_unittests\": \"3c2a9fe70082ffb853bd2fcdf24dd6b04e07e14f\", \"sql_unittests\": \"b8e101946a61216829109025f013108168458553\", \"storage_unittests\": \"0a2bacf045ff7a30d0f184f2f7dacfe0165d5178\", \"sync_integration_tests\": \"406deb0080ecf4619a641b83c4a1091850c3ede9\", \"traffic_annotation_auditor_unittests\": \"740bff8f46b0f8a1fd25348cd8c666972b6b5eda\", \"ui_base_unittests\": \"12112b8be5ac5e1144cc6aa8b55c0a522b932874\", \"ui_touch_selection_unittests\": \"67d6b35be3f15dc6d550b97d8e24c8e752088b1c\", \"unit_tests\": \"26f9bb41a3f95bf8f87c3c97c510c7fd5c6fa00e\", \"updater_tests\": \"83947d39148c54043a103708716677bb2d70f794\", \"url_unittests\": \"8dfe34b466e5d23e8cf04880d23f8fe3df5f4c7d\", \"views_unittests\": \"33f1703379d7d22de7e44781891305f7bfc7da9b\", \"viz_unittests\": \"244f4ba51eaf3bfe955b14d8f61f1d74f8521ff1\", \"vr_common_unittests\": \"cd88ce6375ef40d2b1b38ddaaf513e29659ab49e\", \"vr_pixeltests\": \"13a67e1eeba22e5c829da531cd6d65483ff7289d\", \"weblayer_browsertests\": \"500308cd15e6198321c866d023b2ed7ed025448c\", \"weblayer_unittests\": \"8f9be8f1006c9305940c5f2be540d40bdd292f73\", \"wm_unittests\": \"3631a116ab662711168a5fb315bcae243440ac86\", \"wtf_unittests\": \"40ce0ab736ff44559cf046c475b8cae2c1a0d733\", \"zlib_unittests\": \"f86193f8ab784eec63266b150412ddbe5f48196f\", \"zucchini_unittests\": \"81f6f3d58204784e08040b8c04dfac071215dafd\"}}, \"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-6zek\"], \"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\": [\"5635-1756fdb\"], \"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": "1605694612527589",
"status": "COMPLETED",
"status_changed_ts": "1605698286689715",
"tags": [
"build_address:luci.chromium.ci/win-asan/15702",
"builder:win-asan",
"buildset:commit/git/15cdafe9a819401befdbf450bc0921fcfd02705b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/15cdafe9a819401befdbf450bc0921fcfd02705b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028730946255016480",
"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/8863300884245181536/+/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:4ff3ace807d15a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605698286694232",
"url": "https://ci.chromium.org/b/8863300884245181536",
"utcnow_ts": "1605698287847359"
}
}
[11:18:07.898] Invocation finished in 1h1m18.876640321s with status SUCCEEDED