[10:55:53.013] New invocation is queued and will start shortly
[10:55:54.452] Starting the invocation (attempt 1)
[10:55:54.485] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:55:54.486] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:55:54.486] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025014012797981664",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b80bbb87e9050bca7b59f2e36bc4d2093463976b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9025014012797981664",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/b80bbb87e9050bca7b59f2e36bc4d2093463976b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b80bbb87e9050bca7b59f2e36bc4d2093463976b",
"gitiles_ref:refs/heads/master"
]
}
[10:55:56.224] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609239354630576",
"id": "8859583950438202464",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b80bbb87e9050bca7b59f2e36bc4d2093463976b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609239355903455",
"tags": [
"build_address:luci.chromium.ci/win-asan/16527",
"builder:win-asan",
"buildset:commit/git/b80bbb87e9050bca7b59f2e36bc4d2093463976b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b80bbb87e9050bca7b59f2e36bc4d2093463976b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025014012797981664",
"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/8859583950438202464/+/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": "1609239355903576",
"url": "https://ci.chromium.org/b/8859583950438202464",
"utcnow_ts": "1609239356190963"
}
}
[10:55:56.224] Task URL: https://ci.chromium.org/b/8859583950438202464
[10:55:56.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:2:0) after 1m0s
[10:56:01.708] Received PubSub notification, asking Buildbucket for the build status
[10:56:01.807] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:56.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:2:0)
[10:56:56.748] Timer tick, asking Buildbucket for the build status
[10:56:56.846] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:56.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:4:0) after 1m0s
[10:57:56.929] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:4:0)
[10:57:56.929] Timer tick, asking Buildbucket for the build status
[10:57:57.270] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:57.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:5:0) after 1m0s
[10:58:57.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:5:0)
[10:58:57.304] Timer tick, asking Buildbucket for the build status
[10:58:57.416] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:57.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:6:0) after 1m0s
[10:59:57.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:6:0)
[10:59:57.461] Timer tick, asking Buildbucket for the build status
[10:59:57.591] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:57.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:7:0) after 1m0s
[11:00:57.696] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:7:0)
[11:00:57.696] Timer tick, asking Buildbucket for the build status
[11:00:57.868] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:57.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:8:0) after 1m0s
[11:01:57.905] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:8:0)
[11:01:57.905] Timer tick, asking Buildbucket for the build status
[11:01:58.155] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:58.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:9:0) after 1m0s
[11:02:58.188] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:9:0)
[11:02:58.188] Timer tick, asking Buildbucket for the build status
[11:02:58.328] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:58.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:10:0) after 1m0s
[11:03:58.350] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:10:0)
[11:03:58.350] Timer tick, asking Buildbucket for the build status
[11:03:58.609] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:58.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:11:0) after 1m0s
[11:04:58.611] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:11:0)
[11:04:58.611] Timer tick, asking Buildbucket for the build status
[11:04:58.712] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:58.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:12:0) after 1m0s
[11:05:58.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:12:0)
[11:05:58.694] Timer tick, asking Buildbucket for the build status
[11:05:58.801] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:58.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:13:0) after 1m0s
[11:06:58.828] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:13:0)
[11:06:58.828] Timer tick, asking Buildbucket for the build status
[11:06:58.982] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:58.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:14:0) after 1m0s
[11:07:59.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:14:0)
[11:07:59.116] Timer tick, asking Buildbucket for the build status
[11:07:59.298] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:59.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:15:0) after 1m0s
[11:08:59.307] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:15:0)
[11:08:59.307] Timer tick, asking Buildbucket for the build status
[11:08:59.484] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:59.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:16:0) after 1m0s
[11:09:59.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:16:0)
[11:09:59.507] Timer tick, asking Buildbucket for the build status
[11:10:00.331] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:00.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:17:0) after 1m0s
[11:11:01.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:17:0)
[11:11:01.360] Timer tick, asking Buildbucket for the build status
[11:11:01.638] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:01.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:18:0) after 1m0s
[11:12:01.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:18:0)
[11:12:01.655] Timer tick, asking Buildbucket for the build status
[11:12:02.235] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:02.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:19:0) after 1m0s
[11:13:02.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:19:0)
[11:13:02.287] Timer tick, asking Buildbucket for the build status
[11:13:02.645] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:02.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:20:0) after 1m0s
[11:14:02.766] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:20:0)
[11:14:02.766] Timer tick, asking Buildbucket for the build status
[11:14:03.345] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:03.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:21:0) after 1m0s
[11:15:03.525] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:21:0)
[11:15:03.525] Timer tick, asking Buildbucket for the build status
[11:15:04.085] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:04.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:22:0) after 1m0s
[11:16:04.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:22:0)
[11:16:04.122] Timer tick, asking Buildbucket for the build status
[11:16:04.301] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:04.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:23:0) after 1m0s
[11:17:04.322] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:23:0)
[11:17:04.322] Timer tick, asking Buildbucket for the build status
[11:17:04.485] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:04.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:24:0) after 1m0s
[11:18:04.565] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:24:0)
[11:18:04.565] Timer tick, asking Buildbucket for the build status
[11:18:04.670] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:04.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:25:0) after 1m0s
[11:19:04.800] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:25:0)
[11:19:04.800] Timer tick, asking Buildbucket for the build status
[11:19:04.920] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:04.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:26:0) after 1m0s
[11:20:04.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:26:0)
[11:20:04.939] Timer tick, asking Buildbucket for the build status
[11:20:05.048] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:05.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:27:0) after 1m0s
[11:21:05.189] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:27:0)
[11:21:05.189] Timer tick, asking Buildbucket for the build status
[11:21:05.316] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:05.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:28:0) after 1m0s
[11:22:05.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:28:0)
[11:22:05.488] Timer tick, asking Buildbucket for the build status
[11:22:05.708] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:05.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:29:0) after 1m0s
[11:23:05.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:29:0)
[11:23:05.721] Timer tick, asking Buildbucket for the build status
[11:23:05.990] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:05.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:30:0) after 1m0s
[11:24:06.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:30:0)
[11:24:06.008] Timer tick, asking Buildbucket for the build status
[11:24:06.125] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:06.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:31:0) after 1m0s
[11:25:06.278] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:31:0)
[11:25:06.278] Timer tick, asking Buildbucket for the build status
[11:25:06.386] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:06.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:32:0) after 1m0s
[11:26:06.458] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:32:0)
[11:26:06.458] Timer tick, asking Buildbucket for the build status
[11:26:06.608] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:06.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:33:0) after 1m0s
[11:27:06.698] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:33:0)
[11:27:06.698] Timer tick, asking Buildbucket for the build status
[11:27:06.869] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:06.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:34:0) after 1m0s
[11:28:06.961] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:34:0)
[11:28:06.961] Timer tick, asking Buildbucket for the build status
[11:28:07.071] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:07.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:35:0) after 1m0s
[11:29:07.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:35:0)
[11:29:07.128] Timer tick, asking Buildbucket for the build status
[11:29:07.350] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:07.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:36:0) after 1m0s
[11:30:07.446] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:36:0)
[11:30:07.446] Timer tick, asking Buildbucket for the build status
[11:30:08.227] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:08.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:37:0) after 1m0s
[11:31:08.334] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:37:0)
[11:31:08.334] Timer tick, asking Buildbucket for the build status
[11:31:08.550] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:08.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:38:0) after 1m0s
[11:32:08.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:38:0)
[11:32:08.588] Timer tick, asking Buildbucket for the build status
[11:32:09.160] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:09.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:39:0) after 1m0s
[11:33:09.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:39:0)
[11:33:09.218] Timer tick, asking Buildbucket for the build status
[11:33:09.376] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:09.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:40:0) after 1m0s
[11:34:09.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:40:0)
[11:34:09.453] Timer tick, asking Buildbucket for the build status
[11:34:09.594] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:09.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:41:0) after 1m0s
[11:35:09.671] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:41:0)
[11:35:09.671] Timer tick, asking Buildbucket for the build status
[11:35:09.855] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:09.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:42:0) after 1m0s
[11:36:09.928] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:42:0)
[11:36:09.928] Timer tick, asking Buildbucket for the build status
[11:36:10.097] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:10.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:43:0) after 1m0s
[11:37:10.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:43:0)
[11:37:10.150] Timer tick, asking Buildbucket for the build status
[11:37:10.283] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:10.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:44:0) after 1m0s
[11:38:10.348] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:44:0)
[11:38:10.349] Timer tick, asking Buildbucket for the build status
[11:38:10.909] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:10.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:45:0) after 1m0s
[11:39:10.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:45:0)
[11:39:10.962] Timer tick, asking Buildbucket for the build status
[11:39:11.210] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:11.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:46:0) after 1m0s
[11:40:11.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:46:0)
[11:40:11.179] Timer tick, asking Buildbucket for the build status
[11:40:11.282] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:11.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:47:0) after 1m0s
[11:41:11.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:47:0)
[11:41:11.327] Timer tick, asking Buildbucket for the build status
[11:41:11.449] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:11.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:48:0) after 1m0s
[11:42:11.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:48:0)
[11:42:11.513] Timer tick, asking Buildbucket for the build status
[11:42:11.629] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:11.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:49:0) after 1m0s
[11:43:11.757] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:49:0)
[11:43:11.757] Timer tick, asking Buildbucket for the build status
[11:43:12.019] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:12.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:50:0) after 1m0s
[11:44:12.110] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:50:0)
[11:44:12.110] Timer tick, asking Buildbucket for the build status
[11:44:12.329] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:12.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:51:0) after 1m0s
[11:45:12.357] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:51:0)
[11:45:12.357] Timer tick, asking Buildbucket for the build status
[11:45:12.470] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:12.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:52:0) after 1m0s
[11:46:12.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:52:0)
[11:46:12.528] Timer tick, asking Buildbucket for the build status
[11:46:12.684] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:12.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:53:0) after 1m0s
[11:47:12.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:53:0)
[11:47:12.750] Timer tick, asking Buildbucket for the build status
[11:47:12.864] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:12.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:54:0) after 1m0s
[11:48:12.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:54:0)
[11:48:12.888] Timer tick, asking Buildbucket for the build status
[11:48:13.059] Build 8859583950438202464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:13.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025014012797981664:55:0) after 1m0s
[11:48:36.789] Received PubSub notification, asking Buildbucket for the build status
[11:48:36.901] Build 8859583950438202464: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:48:36.901] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609242515413798",
"created_by": "project:chromium",
"created_ts": "1609239354630576",
"id": "8859583950438202464",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b80bbb87e9050bca7b59f2e36bc4d2093463976b\"}}",
"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\": \"b80bbb87e9050bca7b59f2e36bc4d2093463976b\", \"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-us-central1-b-32-1-2sgf\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16527, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"220642a93da1a6e98b6e6c94f1c7767eb267bf58\", \"got_dawn_revision\": \"0eb61724c8f115bc5f26bd9850f14a1dfcae4216\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"b80bbb87e9050bca7b59f2e36bc4d2093463976b\", \"got_revision_cp\": \"refs/heads/master@{#839564}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"bcfb0a5ada22d472155e73725ec23568f3bc9526\", \"got_v8_revision_cp\": \"refs/heads/8.9.198@{#1}\", \"got_webrtc_revision\": \"1f0df96659aeb6447d5d8959c114f3212fc1ca04\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32884}\", \"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\": \"b80bbb87e9050bca7b59f2e36bc4d2093463976b\", \"swarm_hashes_refs/heads/master(at){#839564}_without_patch\": {\"absl_hardening_tests\": \"ce1f0f9b9b25e3cdf6a07a0e0b76af9716afb48f\", \"accessibility_unittests\": \"7c32fa51efe0d07e02a9c9b670dc0460e0b693ee\", \"angle_unittests\": \"629f3c19f39f7b3a6893736958b8370855b899ec\", \"app_shell_unittests\": \"eb3204bfa4b5811e1ae6f2053b891479d565bbb9\", \"aura_unittests\": \"d376e5aafbc2339a519f2c9fc522ee34b5cc68a6\", \"base_unittests\": \"7b193a80056c606539d30974fda38c0f0e977e5f\", \"base_util_unittests\": \"5c845bf46e78057b517371484642806e1e521fd4\", \"blink_common_unittests\": \"09ae0aca776d8b097606ea0d0d291317e6d90b4c\", \"blink_fuzzer_unittests\": \"0ea4f25fab91246a5ce2314320bb1d9a3c478b12\", \"blink_heap_unittests\": \"876a83de7d10269939b3b2743103159b409e6423\", \"blink_platform_unittests\": \"708ac160c502062bb34f86cc0ed0a2e5240c4e7f\", \"blink_unittests\": \"4ca017091dd19ff0740fa8546c850298655b7790\", \"boringssl_crypto_tests\": \"2504f21ea2ffdfb788e76dcef30b9541551ef265\", \"boringssl_ssl_tests\": \"cedf376879c94d77766e67635c228f52690a5ae8\", \"browser_switcher_bho_unittests\": \"a778b9e8cd53b81c550f894474346318a7bfba9d\", \"browser_tests\": \"5d67c279484ecab2c9ca3472af33167effd763dd\", \"capture_unittests\": \"4813d33a323a0c786d0f5a5f5cc7a9a8fa37b40b\", \"cast_unittests\": \"a986ef688193f438fa1b02777671654ffa560842\", \"cc_unittests\": \"5479eb4466139d6c7c7f56b793d9473ed5f544c6\", \"chrome_app_unittests\": \"ec45de9e6e700a26190b3c2416afbbdd6db0dd39\", \"chrome_cleaner_unittests\": \"f79f942cc29ca8d85143e70499afaadb2fa9b988\", \"chrome_elf_unittests\": \"a87a975cc2b24341826b7f941d1b2d80489fe92d\", \"chromedriver_unittests\": \"78950e83017d2b507d2d037cdd0987fe4fc6862f\", \"components_browsertests\": \"360ab2a1c5e1ca0530831b2567ad9c5bff800ff7\", \"components_unittests\": \"66f4bc590d081fbe0766e50acc2014b5d9c7aac4\", \"compositor_unittests\": \"b2bb96eae5243ed24e053db2db7a7e39201d5dba\", \"content_browsertests\": \"73063f3f9ee9a3dd3287df02588d83f90392f202\", \"content_unittests\": \"034b26ed9289de5d33b8c182676642f06893d516\", \"courgette_unittests\": \"9255ed270c746a4277c076afb8e4ecc0765a665e\", \"crashpad_tests\": \"505482293273a34ff74cf1fe369e89dbddb15977\", \"cronet_tests\": \"9751b795cdf550d60883b69cd71f4387b4f14bf6\", \"cronet_unittests\": \"64c20458ac2d42fc2181388532402257b5bd4d00\", \"crypto_unittests\": \"c48cfbbd3fe8af209aefad43c9d29265df725895\", \"delayloads_unittests\": \"90ae9a3ba5673e2cf40358c39854d4c6263daebb\", \"device_unittests\": \"e4d52aa238f27fa144f6db761602a4653a4ea4a9\", \"display_unittests\": \"b9a1d272acf67ef81fa670032274c3749b53b103\", \"elevation_service_unittests\": \"e9a38b823ef8abc12ca97c217fa344855afa8b1e\", \"events_unittests\": \"3ae099d171ff09988d5861f8fb8795ef68826918\", \"extensions_browsertests\": \"d817a162f465c2e4dce467d1e33e92aef42c8e24\", \"extensions_unittests\": \"4446487bf912d3e8133ce40a9cf7da44f7522045\", \"filesystem_service_unittests\": \"892ee59ac2cd5e4833212dc011983bb70f2d22b2\", \"gcm_unit_tests\": \"48077ef00ac0e20fd104a60ab3360890100a9e77\", \"gcp_unittests\": \"eff3ee4ae485fea0d1a39ddc154abdf79c092adc\", \"gfx_unittests\": \"abbec401f322e63b2079d501478bc04753a5a235\", \"gin_unittests\": \"2db3a08c8c5b59df8751b2e56ab144cad80cbb6c\", \"google_apis_unittests\": \"65e21ec2ca563a03330898119092d0759b05e381\", \"gpu_unittests\": \"8f5a5b356b8f8bc4f3563adcbb1a961e758d675b\", \"gwp_asan_unittests\": \"4ee736f8e9eb3049d0288af289c5b9b8a75d030f\", \"headless_browsertests\": \"c9d5ee2a61368fff815912814f54bb0a107b28a0\", \"headless_unittests\": \"c308267390266f00f2dd521a2399fde71ccb7f45\", \"install_static_unittests\": \"4bf7c43f73bdb4d6b0639d2e4b56712f2e58ddd1\", \"installer_util_unittests\": \"7530d8a203f74ece091cd97196255a199bb64c68\", \"interactive_ui_tests\": \"ed353a76ee6bd3e769f9b5074f836dee77b0ce66\", \"ipc_tests\": \"d38538cf9d6a1f8bdf9651951478956191263ba5\", \"jingle_unittests\": \"fd04cf56fe9c7d1bafe2064efe4ffd33a3afa799\", \"latency_unittests\": \"9ba7c39fefef100225a0118f44b24a5356828a25\", \"libjingle_xmpp_unittests\": \"cbedee92be0a70cea47ff60719e51a5dfc6410fc\", \"liburlpattern_unittests\": \"e83204cc574022d43bc66ff187ae4be4bfd1d3a0\", \"media_blink_unittests\": \"4dd0e06990c9f4c66b6a7c518947c0f1cbc343d8\", \"media_unittests\": \"87548559155c76f353f3ba9b536ced7242fdebec\", \"message_center_unittests\": \"284d11780ba2051963284421c280c42aec7645e9\", \"midi_unittests\": \"7c84af120cd2e87acd6818676d2bcf5a0de44ed9\", \"mojo_core_unittests\": \"19501930761909f9a2dc66e5f038640dca795c62\", \"mojo_unittests\": \"58c85f45dd47d22ba7807e884e391ad4e3b91d09\", \"nacl_loader_unittests\": \"a512ae037ad8a695541180d98b4c90117a110547\", \"native_theme_unittests\": \"c5d03dbd4d336d7deb52c97d35abc6c746a8f7ee\", \"net_unittests\": \"06787ca787f4cd5bfe64c6ee5afa098352719956\", \"notification_helper_unittests\": \"81889c4f100b0b2b2acc7e4694dbdb6410145c08\", \"pdf_unittests\": \"5a4aeb6a4afe66652fc80295def7ab79b2655107\", \"perfetto_unittests\": \"579be7f61edfec382e75f1d9d552160b7eec9df3\", \"ppapi_unittests\": \"26252dff4483f69240a3c5341bd801aa2ed9c745\", \"printing_unittests\": \"76fd6695e8b7f0b9ee54d97b2373b5fe8641d9ff\", \"remoting_unittests\": \"513802408d1a48b05cb3b2bf2348aec448341bbd\", \"sbox_integration_tests\": \"be56f3e66968a0273b92354c28e94f781ea5c76f\", \"sbox_unittests\": \"ebbdcfed84b280a25f8a8f05ce6b0571b4498c4e\", \"sbox_validation_tests\": \"5b1f6785a0e202c160a932a0d96b671710dc02e9\", \"service_manager_unittests\": \"dc4222aa08785945d575c259c7e672fa1432d766\", \"services_unittests\": \"b0f1d35d51399490f29c5d422e4021a3196e6d4f\", \"setup_unittests\": \"a594e217fb1d731d3b0218453a6d8a4161b2872f\", \"shell_dialogs_unittests\": \"4286cb5ddb695244574fb94987c5617c6552073e\", \"skia_unittests\": \"4d279a0dac6113f82053d5d6cb08e3be0ba50a23\", \"snapshot_unittests\": \"4d38b96f02b56938894698d1543a8a0e26b1e8c3\", \"sql_unittests\": \"b45de565cabf3f41cf03e4f4dcf579a0121ba3a4\", \"storage_unittests\": \"4c4fa205d853d660eeb44471e176a0fb0883bd24\", \"sync_integration_tests\": \"23567d1aa4136662b22a7b6323993afad8717c48\", \"traffic_annotation_auditor_unittests\": \"8018029e708e908eb744f04b58b49a1ebcbfaf02\", \"ui_base_unittests\": \"c0b15d289f88277f2b317171ab1277bf68d37818\", \"ui_touch_selection_unittests\": \"9bc08d8df1690f81d3f076cc1e45a17aa4b4e4b3\", \"unit_tests\": \"81466507e241465a358bee6ef603749710ca58f2\", \"updater_tests\": \"79f591352198129a4dba2108ec882f036512a237\", \"url_unittests\": \"cdd3d0fb54aec79cbc533e9ac33408a46cb830be\", \"views_unittests\": \"4a4771b8bf1ee92bb23f7083c861d1d65b6caaf7\", \"viz_unittests\": \"bda9dd3e457ef20d3fc3f11b03b77a507dde61c4\", \"vr_common_unittests\": \"ee4460e2a423a9cefc3072bf8311526079a78de2\", \"vr_pixeltests\": \"fc5a7e87e27c47af2a2258d9aea4c91d208d147c\", \"weblayer_browsertests\": \"817e32dea40aa3e6434af60f32535c57d9bfc2e6\", \"weblayer_unittests\": \"3469528a2c1d0bf20e31eea859c364701931b514\", \"wm_unittests\": \"1e63d5c95632c55fd232d158c660fddf78bf0ed5\", \"wtf_unittests\": \"04e1057dd40218aefcfdb6441f781d15d3c40765\", \"zlib_unittests\": \"e628db89766469d0cdb585c401b421df55196a2b\", \"zucchini_unittests\": \"cdb5b6a1297b26bd6c43ad609c532815f0456100\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-2sgf\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609239360611776",
"status": "COMPLETED",
"status_changed_ts": "1609242515916366",
"tags": [
"build_address:luci.chromium.ci/win-asan/16527",
"builder:win-asan",
"buildset:commit/git/b80bbb87e9050bca7b59f2e36bc4d2093463976b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b80bbb87e9050bca7b59f2e36bc4d2093463976b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025014012797981664",
"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/8859583950438202464/+/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:50c6f574cf4ba910",
"user_agent:luci-scheduler"
],
"updated_ts": "1609242515989785",
"url": "https://ci.chromium.org/b/8859583950438202464",
"utcnow_ts": "1609242516866156"
}
}
[11:48:36.901] Invocation finished in 52m43.904233128s with status SUCCEEDED