[09:51:04.917] New invocation is queued and will start shortly
[09:51:06.101] Starting the invocation (attempt 1)
[09:51:06.159] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:51:06.159] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:51:06.159] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021303614136201040",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7a4bb667ce640705170a5c347ae60bc8ce07ed0b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9021303614136201040",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/7a4bb667ce640705170a5c347ae60bc8ce07ed0b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7a4bb667ce640705170a5c347ae60bc8ce07ed0b",
"gitiles_ref:refs/heads/master"
]
}
[09:51:07.824] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612777866460077",
"id": "8855873551857183072",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7a4bb667ce640705170a5c347ae60bc8ce07ed0b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612777867538465",
"tags": [
"build_address:luci.chromium.ci/win-asan/17237",
"builder:win-asan",
"buildset:commit/git/7a4bb667ce640705170a5c347ae60bc8ce07ed0b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7a4bb667ce640705170a5c347ae60bc8ce07ed0b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021303614136201040",
"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/8855873551857183072/+/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": "1612777867538588",
"url": "https://ci.chromium.org/b/8855873551857183072",
"utcnow_ts": "1612777867812468"
}
}
[09:51:07.824] Task URL: https://ci.chromium.org/b/8855873551857183072
[09:51:07.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:2:0) after 1m0s
[09:51:10.155] Received PubSub notification, asking Buildbucket for the build status
[09:51:10.256] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:07.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:2:0)
[09:52:07.900] Timer tick, asking Buildbucket for the build status
[09:52:08.223] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:08.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:4:0) after 1m0s
[09:53:08.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:4:0)
[09:53:08.242] Timer tick, asking Buildbucket for the build status
[09:53:08.419] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:08.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:5:0) after 1m0s
[09:54:08.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:5:0)
[09:54:08.434] Timer tick, asking Buildbucket for the build status
[09:54:08.635] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:08.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:6:0) after 1m0s
[09:55:08.717] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:6:0)
[09:55:08.717] Timer tick, asking Buildbucket for the build status
[09:55:09.117] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:09.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:7:0) after 1m0s
[09:56:09.137] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:7:0)
[09:56:09.137] Timer tick, asking Buildbucket for the build status
[09:56:09.419] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:09.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:8:0) after 1m0s
[09:57:09.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:8:0)
[09:57:09.436] Timer tick, asking Buildbucket for the build status
[09:57:09.738] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:09.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:9:0) after 1m0s
[09:58:09.766] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:9:0)
[09:58:09.766] Timer tick, asking Buildbucket for the build status
[09:58:10.110] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:10.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:10:0) after 1m0s
[09:59:10.161] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:10:0)
[09:59:10.161] Timer tick, asking Buildbucket for the build status
[09:59:10.362] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:10.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:11:0) after 1m0s
[10:00:10.411] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:11:0)
[10:00:10.411] Timer tick, asking Buildbucket for the build status
[10:00:10.584] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:10.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:12:0) after 1m0s
[10:01:10.602] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:12:0)
[10:01:10.602] Timer tick, asking Buildbucket for the build status
[10:01:10.683] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:10.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:13:0) after 1m0s
[10:02:10.733] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:13:0)
[10:02:10.733] Timer tick, asking Buildbucket for the build status
[10:02:11.150] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:11.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:14:0) after 1m0s
[10:03:11.170] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:14:0)
[10:03:11.170] Timer tick, asking Buildbucket for the build status
[10:03:11.255] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:11.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:15:0) after 1m0s
[10:04:11.273] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:15:0)
[10:04:11.273] Timer tick, asking Buildbucket for the build status
[10:04:11.444] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:11.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:16:0) after 1m0s
[10:05:11.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:16:0)
[10:05:11.461] Timer tick, asking Buildbucket for the build status
[10:05:11.524] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:11.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:17:0) after 1m0s
[10:06:11.542] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:17:0)
[10:06:11.542] Timer tick, asking Buildbucket for the build status
[10:06:11.784] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:11.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:18:0) after 1m0s
[10:07:11.763] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:18:0)
[10:07:11.763] Timer tick, asking Buildbucket for the build status
[10:07:12.133] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:12.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:19:0) after 1m0s
[10:08:12.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:19:0)
[10:08:12.211] Timer tick, asking Buildbucket for the build status
[10:08:12.412] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:12.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:20:0) after 1m0s
[10:09:12.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:20:0)
[10:09:12.591] Timer tick, asking Buildbucket for the build status
[10:09:12.925] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:12.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:21:0) after 1m0s
[10:10:12.931] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:21:0)
[10:10:12.931] Timer tick, asking Buildbucket for the build status
[10:10:13.330] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:13.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:22:0) after 1m0s
[10:11:14.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:22:0)
[10:11:14.402] Timer tick, asking Buildbucket for the build status
[10:11:14.535] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:14.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:23:0) after 1m0s
[10:12:14.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:23:0)
[10:12:14.641] Timer tick, asking Buildbucket for the build status
[10:12:14.738] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:14.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:24:0) after 1m0s
[10:13:14.834] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:24:0)
[10:13:14.834] Timer tick, asking Buildbucket for the build status
[10:13:14.970] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:14.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:25:0) after 1m0s
[10:14:15.029] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:25:0)
[10:14:15.029] Timer tick, asking Buildbucket for the build status
[10:14:15.167] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:15.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:26:0) after 1m0s
[10:15:15.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:26:0)
[10:15:15.281] Timer tick, asking Buildbucket for the build status
[10:15:15.392] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:15.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:27:0) after 1m0s
[10:16:15.476] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:27:0)
[10:16:15.476] Timer tick, asking Buildbucket for the build status
[10:16:15.603] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:15.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:28:0) after 1m0s
[10:17:15.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:28:0)
[10:17:15.596] Timer tick, asking Buildbucket for the build status
[10:17:15.718] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:15.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:29:0) after 1m0s
[10:18:15.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:29:0)
[10:18:15.692] Timer tick, asking Buildbucket for the build status
[10:18:16.343] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:16.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:30:0) after 1m0s
[10:19:16.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:30:0)
[10:19:16.367] Timer tick, asking Buildbucket for the build status
[10:19:16.485] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:16.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:31:0) after 1m0s
[10:20:16.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:31:0)
[10:20:16.528] Timer tick, asking Buildbucket for the build status
[10:20:16.590] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:16.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:32:0) after 1m0s
[10:21:16.673] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:32:0)
[10:21:16.673] Timer tick, asking Buildbucket for the build status
[10:21:17.254] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:17.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:33:0) after 1m0s
[10:22:17.233] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:33:0)
[10:22:17.233] Timer tick, asking Buildbucket for the build status
[10:22:17.390] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:17.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:34:0) after 1m0s
[10:23:17.480] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:34:0)
[10:23:17.480] Timer tick, asking Buildbucket for the build status
[10:23:17.550] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:17.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:35:0) after 1m0s
[10:24:17.620] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:35:0)
[10:24:17.620] Timer tick, asking Buildbucket for the build status
[10:24:17.694] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:17.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:36:0) after 1m0s
[10:25:17.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:36:0)
[10:25:17.865] Timer tick, asking Buildbucket for the build status
[10:25:17.944] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:17.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:37:0) after 1m0s
[10:26:17.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:37:0)
[10:26:17.949] Timer tick, asking Buildbucket for the build status
[10:26:18.079] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:18.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:38:0) after 1m0s
[10:27:18.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:38:0)
[10:27:18.130] Timer tick, asking Buildbucket for the build status
[10:27:18.229] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:18.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:39:0) after 1m0s
[10:28:18.344] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:39:0)
[10:28:18.344] Timer tick, asking Buildbucket for the build status
[10:28:18.443] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:18.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:40:0) after 1m0s
[10:29:18.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:40:0)
[10:29:18.495] Timer tick, asking Buildbucket for the build status
[10:29:18.870] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:18.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:41:0) after 1m0s
[10:30:18.964] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:41:0)
[10:30:18.964] Timer tick, asking Buildbucket for the build status
[10:30:19.657] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:19.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:42:0) after 1m0s
[10:31:19.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:42:0)
[10:31:19.728] Timer tick, asking Buildbucket for the build status
[10:31:19.909] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:19.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:43:0) after 1m0s
[10:32:20.182] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:43:0)
[10:32:20.182] Timer tick, asking Buildbucket for the build status
[10:32:20.509] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:20.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:44:0) after 1m0s
[10:33:20.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:44:0)
[10:33:20.729] Timer tick, asking Buildbucket for the build status
[10:33:20.827] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:20.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:45:0) after 1m0s
[10:34:21.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:45:0)
[10:34:21.014] Timer tick, asking Buildbucket for the build status
[10:34:22.221] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:22.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:46:0) after 1m0s
[10:35:22.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:46:0)
[10:35:22.408] Timer tick, asking Buildbucket for the build status
[10:35:22.804] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:22.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:47:0) after 1m0s
[10:36:23.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:47:0)
[10:36:23.001] Timer tick, asking Buildbucket for the build status
[10:36:23.247] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:23.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:48:0) after 1m0s
[10:37:23.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:48:0)
[10:37:23.697] Timer tick, asking Buildbucket for the build status
[10:37:23.804] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:23.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:49:0) after 1m0s
[10:38:23.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:49:0)
[10:38:23.923] Timer tick, asking Buildbucket for the build status
[10:38:24.009] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:24.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:50:0) after 1m0s
[10:39:24.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:50:0)
[10:39:24.025] Timer tick, asking Buildbucket for the build status
[10:39:24.103] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:24.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:51:0) after 1m0s
[10:40:24.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:51:0)
[10:40:24.205] Timer tick, asking Buildbucket for the build status
[10:40:24.274] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:24.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:52:0) after 1m0s
[10:41:24.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:52:0)
[10:41:24.341] Timer tick, asking Buildbucket for the build status
[10:41:24.456] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:24.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:53:0) after 1m0s
[10:42:24.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:53:0)
[10:42:24.655] Timer tick, asking Buildbucket for the build status
[10:42:25.118] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:25.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:54:0) after 1m0s
[10:43:25.190] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:54:0)
[10:43:25.190] Timer tick, asking Buildbucket for the build status
[10:43:25.976] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:25.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:55:0) after 1m0s
[10:44:26.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:55:0)
[10:44:26.163] Timer tick, asking Buildbucket for the build status
[10:44:26.308] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:26.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:56:0) after 1m0s
[10:45:26.363] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:56:0)
[10:45:26.363] Timer tick, asking Buildbucket for the build status
[10:45:26.624] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:26.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:57:0) after 1m0s
[10:46:26.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:57:0)
[10:46:26.732] Timer tick, asking Buildbucket for the build status
[10:46:26.895] Build 8855873551857183072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:26.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021303614136201040:58:0) after 1m0s
[10:46:51.993] Received PubSub notification, asking Buildbucket for the build status
[10:46:52.066] Build 8855873551857183072: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:46:52.066] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612781211046540",
"created_by": "project:chromium",
"created_ts": "1612777866460077",
"id": "8855873551857183072",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7a4bb667ce640705170a5c347ae60bc8ce07ed0b\"}}",
"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\": \"7a4bb667ce640705170a5c347ae60bc8ce07ed0b\", \"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-7-1hzs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17237, \"clang_revision\": \"llvmorg-13-init-794-g83e2710e-1\", \"got_angle_revision\": \"6b20e1c884885eb6a5603e88a561a3ba21cc615b\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"7a4bb667ce640705170a5c347ae60bc8ce07ed0b\", \"got_revision_cp\": \"refs/heads/master@{#851639}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"266614a36dbd5328a9079ea6bbef9026c7bbe3d7\", \"got_v8_revision\": \"462378addab907ab7452d38baccb27fe2ef7289a\", \"got_v8_revision_cp\": \"refs/heads/9.0.138@{#1}\", \"got_webrtc_revision\": \"69c0118c5139a1a6b431d2f3f812dc9ed6af6b74\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33186}\", \"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\": \"7a4bb667ce640705170a5c347ae60bc8ce07ed0b\", \"swarm_hashes_refs/heads/master(at){#851639}_without_patch\": {\"absl_hardening_tests\": \"e923a172c088f98e05d18ec38e1f1a09870cd82b\", \"accessibility_unittests\": \"652bebe66f18911222eb898dda026c9109a2b773\", \"angle_unittests\": \"4c56b8d542e88a7950c7c433d6b10b4567bed2ba\", \"app_shell_unittests\": \"3ef1aaa9e53bfd0fb4d96c59ed4625ee1aba94fa\", \"aura_unittests\": \"aa776192b4ccd218f3c5e5769491ca6d6ab73030\", \"base_unittests\": \"81f189f0845d4f4fb7c87d7f00657ce68c32a75e\", \"base_util_unittests\": \"cac3139eb4c7310596545a872b20b3535465153c\", \"blink_common_unittests\": \"56dfbd9eb5dbd5eb9f27f0c2e46fed5d4f17010a\", \"blink_fuzzer_unittests\": \"d6d24f548ec7d09d50a1252556268a9baccdcaa2\", \"blink_heap_unittests\": \"2bc72c55d306c4b06951efbd171c8849623d2455\", \"blink_platform_unittests\": \"a5293d839474c4614a4c8d948b9db4ce1f557edc\", \"blink_unittests\": \"d2dbf64f8ee5d02ad7aff99734162b1ea7605614\", \"boringssl_crypto_tests\": \"2ce249d500b147cb8b3383d194860d56c98980e5\", \"boringssl_ssl_tests\": \"285463a5fbab12512d318753623a9364b24cc624\", \"browser_switcher_bho_unittests\": \"b0e86d55a229bc47f2f00fdc763151c979864031\", \"browser_tests\": \"4a7627a6e261a913b33461c5d1faf5505202c7db\", \"capture_unittests\": \"5effa706d4c924fb06514744b4d63dccb76ddb71\", \"cast_unittests\": \"1b6702212a8bd68f5d71871414b4f0aeb62f887b\", \"cc_unittests\": \"2bb8df30a799ca12cd6060c08a2a1b202cb81729\", \"chrome_app_unittests\": \"23554cc3821fd813acba91280fea681f8f8af4b7\", \"chrome_cleaner_unittests\": \"16d15e1d02d791f385a8fc0d5f7ee8e3bb7fa731\", \"chrome_elf_unittests\": \"98e50ea4794e1fe998533fa88c6c1cbf187107c2\", \"chromedriver_unittests\": \"3dafe8cc45074ca5f3bc3e6ffe704b20c4a4203b\", \"components_browsertests\": \"43f41e9edc6a7885554e452e1482e2a3b73d7d00\", \"components_unittests\": \"e90b3d0e48e31e4242ac16a13c465be58fb120a7\", \"compositor_unittests\": \"67510517f03bdd5d7c57df11552097a3d10adde1\", \"content_browsertests\": \"cc583c149d7e2faf2fc218d90c3907d52ab068a7\", \"content_unittests\": \"591aa0481d0da4eabf7785b91203d68ee07c2e71\", \"courgette_unittests\": \"227317c338ac853b0db91a6712b18156ca99beef\", \"crashpad_tests\": \"659ce6a3aa3f7bd13949413748e068bee8f094a7\", \"cronet_tests\": \"e48cdce59179f1c7b4debf2f379ed52de213d5cb\", \"cronet_unittests\": \"7c741bd6691e07cd6495d426cc0c1ad5fa1c04f6\", \"crypto_unittests\": \"019ce5214aeac7b9ac33888c8e1feff043d7a407\", \"delayloads_unittests\": \"676f4c20eeceeb725326e62297795c3860a357cd\", \"device_unittests\": \"237fbb85e8e1be9406b378e2f5af0570fe92dce9\", \"display_unittests\": \"c856634c238cf2cb4e6b16f0056489c584a97295\", \"elevation_service_unittests\": \"e1dc02bb9c5e3f463321ef7dc2408d39d42f3836\", \"events_unittests\": \"626241691f9405ab3e3f93af3532e7620763273d\", \"extensions_browsertests\": \"1f585e1f2b56e9b567348263f081adbeaf33cd20\", \"extensions_unittests\": \"e1167f5eda19b6cb4eb178411404eb76c1f14884\", \"filesystem_service_unittests\": \"f5203684e6a5572a42b80d920341efd6bd7cb6fa\", \"gcm_unit_tests\": \"9a2b3cc714aa032a00f8444ac8b3501478df2574\", \"gcp_unittests\": \"12224b7442be16e62234bbf66c881821b11c35c3\", \"gfx_unittests\": \"0c5c9caa8f228861b2563c5f69efcd0bf43d02af\", \"gin_unittests\": \"3f1f57455883b9d84012ff738be54a8e942e5050\", \"google_apis_unittests\": \"1c8457e6286f52f02b863d37ec6821cccd0c3761\", \"gpu_unittests\": \"8a636fb8e9ff2bd4dd3993cf169eb65200fc4056\", \"gwp_asan_unittests\": \"c3e390a489c6b38809020c26229665d2f4d1e4b6\", \"headless_browsertests\": \"dd64c92f2311b599e4cea3081c09903ab848411c\", \"headless_unittests\": \"10d9919d71d3901c1eca0a71543044be48d67e5c\", \"install_static_unittests\": \"fa0be9393cf2b60d06941a4e3147a34b2ae9bc0d\", \"installer_util_unittests\": \"93c3fb4299fd63aeb80b2fe1ca7a5ce5942eb8ba\", \"interactive_ui_tests\": \"ea4b4dc2e03b9e84a6f10db7490e49dfd82c7c17\", \"ipc_tests\": \"979222984a13ac3caed867431102b59bdc3c4365\", \"jingle_unittests\": \"83f9e9b3177a560e6e4e530b622910e53baa0b4c\", \"latency_unittests\": \"cc6a1249570d04ac4002c23c0f0148295ad37a8b\", \"libjingle_xmpp_unittests\": \"e5a88047c4a5809b812962c6d79bcbc7bb9a0e1b\", \"liburlpattern_unittests\": \"1e38d5b7f267e3ca5b11688cd8ab3152c7d9bee0\", \"media_blink_unittests\": \"ad8240bda286531705735797fd2d18abe222ea54\", \"media_unittests\": \"a3095c2333d6e07c7bacd93c4e6205592301841c\", \"message_center_unittests\": \"77a513c2be66903c3faca3aafa617084ac5e4b53\", \"midi_unittests\": \"07fc535839e9fcd4a579240f63dc0d446b55836b\", \"mojo_core_unittests\": \"61a9f0b3426be0e1622a2433fa95a2be2b3f5c49\", \"mojo_unittests\": \"02811fb31fd2e8c23e9c94115a4ee0052aac0266\", \"nacl_loader_unittests\": \"385472081249d07dc2431d993a3534adacf7104d\", \"native_theme_unittests\": \"12ea67b9ba5b38821435430f23e18167718ef17e\", \"net_unittests\": \"0f82ebd3fd034069e00b0cf8d20127e659dd3c0a\", \"notification_helper_unittests\": \"a9f9883910c65b05b31cb50470654723208f52c1\", \"pdf_unittests\": \"24d0506263ba7c3eba57f08a7022996f6348fc73\", \"perfetto_unittests\": \"a006052ed55b90510625c6629b5c6c6eebf448ff\", \"ppapi_unittests\": \"eabb0a1a40de6220673f42b30923826b3a775158\", \"printing_unittests\": \"3be7801c8c593308ee4489dd9553f5854db100ad\", \"remoting_unittests\": \"82fbd001a955ad5149cea16a5049b268a1cf4f17\", \"sbox_integration_tests\": \"7834297f0b2125a54210a55c9f289e85925a8f01\", \"sbox_unittests\": \"c3561d031d353db6e4aba1992cb3d5f48902aa64\", \"sbox_validation_tests\": \"9e1cc4ffee760e39ebd3273281939f4c71336314\", \"service_manager_unittests\": \"760bc4ab86c7e13c7e6f36200524060862767da9\", \"services_unittests\": \"809b21a38d653462f113bb3371e4679be9b3faeb\", \"setup_unittests\": \"7e0d8371fabee2b4a35146006045f676feeaced4\", \"shell_dialogs_unittests\": \"50a4e09483d06adde3bcdb1308f8884ca7d3a315\", \"skia_unittests\": \"59c827e281c639ccac26a6aae1c8062d454a528b\", \"snapshot_unittests\": \"b8e40baab8f5e7fc4c88d49dd6ddb6a33d126e56\", \"sql_unittests\": \"79bf7f461d34af2644e12f3f91df634c6153adc1\", \"storage_unittests\": \"a6bdbb7ffd36a99929ff3e4f639bb34a11db48ad\", \"sync_integration_tests\": \"59851f6e4dee3359a4f15560a3a740dde6c24e49\", \"traffic_annotation_auditor_unittests\": \"9cf4231e23378d54a7c92e87c281b69687f92b1c\", \"ui_base_unittests\": \"399cc31b6eca07858fe0b53fc332c88bdd3ba6b7\", \"ui_touch_selection_unittests\": \"a9bae58fa2410e351b2870f8afbc85529ee2c6fd\", \"unit_tests\": \"63651d7ac9b6442685f98b75edaa0076f1494acd\", \"updater_tests\": \"19ec8887a83a57641cffb95500a86a2e4edd0428\", \"url_unittests\": \"3d339b31ceceaab22834c71d3a9ff58b6b1096c7\", \"views_unittests\": \"81be4b198f725a4b01c29fa894cc0d98a86659be\", \"viz_unittests\": \"7e360e3684653e2afb929958c90edba27b3b7c1e\", \"vr_common_unittests\": \"0a45e3be484bbd838292e29550aa914c16e5d77e\", \"vr_pixeltests\": \"559700e67d53fe91d15bbbe26a38b7507ef8d39d\", \"weblayer_browsertests\": \"78ea5148171182cc27daf325c0e462ef545081f6\", \"weblayer_unittests\": \"4651e7d5b26c6db66661115f59e85d33814f565f\", \"wm_unittests\": \"0677d29094d116bb5e472f88c3a6b8ea12536bf4\", \"wtf_unittests\": \"681981bd2f026dc712b0907dc0c139942c12f29f\", \"zlib_unittests\": \"900318e66f2280297884e1cf9aebe09bf35a6c96\", \"zucchini_unittests\": \"d2c53134b45b4fe241590a278f97769626ed653f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_27a86a15ec8feb386a5b02e9d1f544a49194bc134f7348519b0bd6cd38b20371_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-7-1hzs\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5681-01e7fd1\"], \"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": "1612777868338048",
"status": "COMPLETED",
"status_changed_ts": "1612781211461219",
"tags": [
"build_address:luci.chromium.ci/win-asan/17237",
"builder:win-asan",
"buildset:commit/git/7a4bb667ce640705170a5c347ae60bc8ce07ed0b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7a4bb667ce640705170a5c347ae60bc8ce07ed0b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021303614136201040",
"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/8855873551857183072/+/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:5199ded296049910",
"user_agent:luci-scheduler"
],
"updated_ts": "1612781211465173",
"url": "https://ci.chromium.org/b/8855873551857183072",
"utcnow_ts": "1612781212052145"
}
}
[10:46:52.066] Invocation finished in 55m47.162771295s with status SUCCEEDED