[19:46:28.687] New invocation is queued and will start shortly
[19:46:29.994] Starting the invocation (attempt 1)
[19:46:30.028] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:46:30.028] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:46:30.028] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025433615506184496",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dd424da8616d687028029c1879ebfdb5b0f1d752\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9025433615506184496",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/dd424da8616d687028029c1879ebfdb5b0f1d752",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd424da8616d687028029c1879ebfdb5b0f1d752",
"gitiles_ref:refs/heads/master"
]
}
[19:46:30.984] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608839190124995",
"id": "8860003553335214208",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd424da8616d687028029c1879ebfdb5b0f1d752\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608839190689175",
"tags": [
"build_address:luci.chromium.ci/win-asan/16428",
"builder:win-asan",
"buildset:commit/git/dd424da8616d687028029c1879ebfdb5b0f1d752",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd424da8616d687028029c1879ebfdb5b0f1d752",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025433615506184496",
"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/8860003553335214208/+/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": "1608839190689380",
"url": "https://ci.chromium.org/b/8860003553335214208",
"utcnow_ts": "1608839190974449"
}
}
[19:46:30.984] Task URL: https://ci.chromium.org/b/8860003553335214208
[19:46:30.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:2:0) after 1m0s
[19:46:33.003] Received PubSub notification, asking Buildbucket for the build status
[19:46:33.062] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:31.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:2:0)
[19:47:31.044] Timer tick, asking Buildbucket for the build status
[19:47:31.138] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:31.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:4:0) after 1m0s
[19:48:31.157] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:4:0)
[19:48:31.157] Timer tick, asking Buildbucket for the build status
[19:48:31.245] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:31.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:5:0) after 1m0s
[19:49:31.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:5:0)
[19:49:31.685] Timer tick, asking Buildbucket for the build status
[19:49:31.837] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:31.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:6:0) after 1m0s
[19:50:31.910] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:6:0)
[19:50:31.910] Timer tick, asking Buildbucket for the build status
[19:50:32.353] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:32.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:7:0) after 1m0s
[19:51:32.429] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:7:0)
[19:51:32.429] Timer tick, asking Buildbucket for the build status
[19:51:32.571] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:32.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:8:0) after 1m0s
[19:52:32.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:8:0)
[19:52:32.657] Timer tick, asking Buildbucket for the build status
[19:52:32.722] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:32.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:9:0) after 1m0s
[19:53:32.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:9:0)
[19:53:32.792] Timer tick, asking Buildbucket for the build status
[19:53:32.877] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:32.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:10:0) after 1m0s
[19:54:33.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:10:0)
[19:54:33.045] Timer tick, asking Buildbucket for the build status
[19:54:33.144] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:33.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:11:0) after 1m0s
[19:55:33.117] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:11:0)
[19:55:33.117] Timer tick, asking Buildbucket for the build status
[19:55:33.219] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:33.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:12:0) after 1m0s
[19:56:33.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:12:0)
[19:56:33.298] Timer tick, asking Buildbucket for the build status
[19:56:33.484] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:33.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:13:0) after 1m0s
[19:57:33.571] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:13:0)
[19:57:33.571] Timer tick, asking Buildbucket for the build status
[19:57:33.633] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:33.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:14:0) after 1m0s
[19:58:33.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:14:0)
[19:58:33.899] Timer tick, asking Buildbucket for the build status
[19:58:33.963] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:33.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:15:0) after 1m0s
[19:59:34.166] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:15:0)
[19:59:34.166] Timer tick, asking Buildbucket for the build status
[19:59:34.279] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:34.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:16:0) after 1m0s
[20:00:34.516] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:16:0)
[20:00:34.516] Timer tick, asking Buildbucket for the build status
[20:00:34.639] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:34.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:17:0) after 1m0s
[20:01:35.075] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:17:0)
[20:01:35.075] Timer tick, asking Buildbucket for the build status
[20:01:35.435] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:35.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:18:0) after 1m0s
[20:02:35.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:18:0)
[20:02:35.493] Timer tick, asking Buildbucket for the build status
[20:02:35.618] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:35.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:19:0) after 1m0s
[20:03:36.419] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:19:0)
[20:03:36.419] Timer tick, asking Buildbucket for the build status
[20:03:36.512] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:36.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:20:0) after 1m0s
[20:04:36.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:20:0)
[20:04:36.877] Timer tick, asking Buildbucket for the build status
[20:04:36.986] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:36.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:21:0) after 1m0s
[20:05:37.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:21:0)
[20:05:37.107] Timer tick, asking Buildbucket for the build status
[20:05:37.179] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:37.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:22:0) after 1m0s
[20:06:37.208] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:22:0)
[20:06:37.208] Timer tick, asking Buildbucket for the build status
[20:06:37.314] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:37.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:23:0) after 1m0s
[20:07:37.338] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:23:0)
[20:07:37.338] Timer tick, asking Buildbucket for the build status
[20:07:37.433] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:37.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:24:0) after 1m0s
[20:08:37.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:24:0)
[20:08:37.451] Timer tick, asking Buildbucket for the build status
[20:08:37.564] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:37.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:25:0) after 1m0s
[20:09:37.780] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:25:0)
[20:09:37.780] Timer tick, asking Buildbucket for the build status
[20:09:38.388] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:38.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:26:0) after 1m0s
[20:10:38.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:26:0)
[20:10:38.655] Timer tick, asking Buildbucket for the build status
[20:10:39.023] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:39.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:27:0) after 1m0s
[20:11:39.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:27:0)
[20:11:39.048] Timer tick, asking Buildbucket for the build status
[20:11:39.153] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:39.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:28:0) after 1m0s
[20:12:39.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:28:0)
[20:12:39.205] Timer tick, asking Buildbucket for the build status
[20:12:39.276] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:39.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:29:0) after 1m0s
[20:13:39.285] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:29:0)
[20:13:39.285] Timer tick, asking Buildbucket for the build status
[20:13:39.353] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:39.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:30:0) after 1m0s
[20:14:39.805] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:30:0)
[20:14:39.805] Timer tick, asking Buildbucket for the build status
[20:14:39.896] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:39.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:31:0) after 1m0s
[20:15:40.142] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:31:0)
[20:15:40.142] Timer tick, asking Buildbucket for the build status
[20:15:40.407] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:40.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:32:0) after 1m0s
[20:16:40.559] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:32:0)
[20:16:40.559] Timer tick, asking Buildbucket for the build status
[20:16:40.694] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:40.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:33:0) after 1m0s
[20:17:40.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:33:0)
[20:17:40.777] Timer tick, asking Buildbucket for the build status
[20:17:40.841] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:40.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:34:0) after 1m0s
[20:18:40.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:34:0)
[20:18:40.837] Timer tick, asking Buildbucket for the build status
[20:18:40.903] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:40.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:35:0) after 1m0s
[20:19:40.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:35:0)
[20:19:40.925] Timer tick, asking Buildbucket for the build status
[20:19:40.996] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:40.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:36:0) after 1m0s
[20:20:41.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:36:0)
[20:20:41.066] Timer tick, asking Buildbucket for the build status
[20:20:41.132] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:41.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:37:0) after 1m0s
[20:21:41.206] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:37:0)
[20:21:41.206] Timer tick, asking Buildbucket for the build status
[20:21:41.689] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:41.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:38:0) after 1m0s
[20:22:41.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:38:0)
[20:22:41.802] Timer tick, asking Buildbucket for the build status
[20:22:41.880] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:41.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:39:0) after 1m0s
[20:23:41.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:39:0)
[20:23:41.936] Timer tick, asking Buildbucket for the build status
[20:23:42.075] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:42.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:40:0) after 1m0s
[20:24:42.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:40:0)
[20:24:42.134] Timer tick, asking Buildbucket for the build status
[20:24:42.272] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:42.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:41:0) after 1m0s
[20:25:42.383] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:41:0)
[20:25:42.383] Timer tick, asking Buildbucket for the build status
[20:25:42.581] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:42.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:42:0) after 1m0s
[20:26:42.601] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:42:0)
[20:26:42.601] Timer tick, asking Buildbucket for the build status
[20:26:42.715] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:42.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:43:0) after 1m0s
[20:27:42.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:43:0)
[20:27:42.753] Timer tick, asking Buildbucket for the build status
[20:27:42.828] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:42.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:44:0) after 1m0s
[20:28:42.928] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:44:0)
[20:28:42.928] Timer tick, asking Buildbucket for the build status
[20:28:43.056] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:43.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:45:0) after 1m0s
[20:29:43.164] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:45:0)
[20:29:43.164] Timer tick, asking Buildbucket for the build status
[20:29:43.263] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:43.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:46:0) after 1m0s
[20:30:43.296] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:46:0)
[20:30:43.296] Timer tick, asking Buildbucket for the build status
[20:30:43.446] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:43.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:47:0) after 1m0s
[20:31:43.474] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:47:0)
[20:31:43.474] Timer tick, asking Buildbucket for the build status
[20:31:43.636] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:43.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:48:0) after 1m0s
[20:32:43.613] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:48:0)
[20:32:43.613] Timer tick, asking Buildbucket for the build status
[20:32:43.706] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:43.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:49:0) after 1m0s
[20:33:43.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:49:0)
[20:33:43.791] Timer tick, asking Buildbucket for the build status
[20:33:44.084] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:44.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:50:0) after 1m0s
[20:34:44.105] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:50:0)
[20:34:44.105] Timer tick, asking Buildbucket for the build status
[20:34:44.715] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:44.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:51:0) after 1m0s
[20:35:44.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:51:0)
[20:35:44.736] Timer tick, asking Buildbucket for the build status
[20:35:45.494] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:45.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:52:0) after 1m0s
[20:36:45.514] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:52:0)
[20:36:45.514] Timer tick, asking Buildbucket for the build status
[20:36:45.646] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:45.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:53:0) after 1m0s
[20:37:45.671] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:53:0)
[20:37:45.671] Timer tick, asking Buildbucket for the build status
[20:37:45.744] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:45.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:54:0) after 1m0s
[20:38:45.778] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:54:0)
[20:38:45.778] Timer tick, asking Buildbucket for the build status
[20:38:45.887] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:45.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:55:0) after 1m0s
[20:39:45.953] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:55:0)
[20:39:45.953] Timer tick, asking Buildbucket for the build status
[20:39:46.383] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:46.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:56:0) after 1m0s
[20:40:46.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:56:0)
[20:40:46.510] Timer tick, asking Buildbucket for the build status
[20:40:46.792] Build 8860003553335214208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:46.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025433615506184496:57:0) after 1m0s
[20:41:40.802] Received PubSub notification, asking Buildbucket for the build status
[20:41:40.875] Build 8860003553335214208: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:41:40.875] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608842497867034",
"created_by": "project:chromium",
"created_ts": "1608839190124995",
"id": "8860003553335214208",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd424da8616d687028029c1879ebfdb5b0f1d752\"}}",
"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\": \"dd424da8616d687028029c1879ebfdb5b0f1d752\", \"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\": 16428, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"26c8aaadd1e18060824e5802164ffd97329aba6f\", \"got_dawn_revision\": \"c8d5277e86ee8c51b1dd7892b41e83eb26ac2ede\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"dd424da8616d687028029c1879ebfdb5b0f1d752\", \"got_revision_cp\": \"refs/heads/master@{#839278}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"40ac7da794ba532291f2e1ce206293e9da982243\", \"got_v8_revision_cp\": \"refs/heads/8.9.189@{#1}\", \"got_webrtc_revision\": \"a45df0b3491ea72cfcf40e21106eb046c8594223\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32879}\", \"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\": \"dd424da8616d687028029c1879ebfdb5b0f1d752\", \"swarm_hashes_refs/heads/master(at){#839278}_without_patch\": {\"absl_hardening_tests\": \"ce1f0f9b9b25e3cdf6a07a0e0b76af9716afb48f\", \"accessibility_unittests\": \"97a02478eb6921990a415db79ac7e6829884762d\", \"angle_unittests\": \"b726e22fba4937a1ab746a22bc7941e4681dd571\", \"app_shell_unittests\": \"49f9f48c0768068edba223c44ca5afd2f9d4f98e\", \"aura_unittests\": \"06c3ebf38ee0f8eabcea11569ccf1528f25b4254\", \"base_unittests\": \"beed3742c37f005bf3a7a447976e605bb0950db6\", \"base_util_unittests\": \"5c845bf46e78057b517371484642806e1e521fd4\", \"blink_common_unittests\": \"e3275fc31901ad3734fb0796edef9a3a2adeb777\", \"blink_fuzzer_unittests\": \"b8fd454adff72e4ce0840d6fcfd4eccc2364fe2e\", \"blink_heap_unittests\": \"a5a79bf537a5c136047977030aeb936a9513c722\", \"blink_platform_unittests\": \"1b814e8782d72138343ca7bc601b2c499fbc9ab2\", \"blink_unittests\": \"7323ef93c9c376b7c56fc41f5e28068a57ece3fd\", \"boringssl_crypto_tests\": \"2504f21ea2ffdfb788e76dcef30b9541551ef265\", \"boringssl_ssl_tests\": \"cedf376879c94d77766e67635c228f52690a5ae8\", \"browser_switcher_bho_unittests\": \"a778b9e8cd53b81c550f894474346318a7bfba9d\", \"browser_tests\": \"38da58927ddd79f39b83c3bfa41c891efe15f718\", \"capture_unittests\": \"cb47591575420de94523caf58bd05e94c48b826d\", \"cast_unittests\": \"c89b742d456e6a1c40fd645d2ae9605173abc625\", \"cc_unittests\": \"cc0371161c6c83310c5eb177354b3fc02f856695\", \"chrome_app_unittests\": \"ee87216229ff484915707db5eaedb9c75f489d70\", \"chrome_cleaner_unittests\": \"691f158d43a9f7d9058ceefbe7df7098427cd734\", \"chrome_elf_unittests\": \"532d3d3c5c02be7cdac7192d42f84acf6d482cbb\", \"chromedriver_unittests\": \"6f48560d4b5b7cc0b3dc7873fcf162722a0293a9\", \"components_browsertests\": \"0ba2523dc82d165562fd60231ceb1f585dfab057\", \"components_unittests\": \"6c2ac61ee0e9d95bebadc118c8e426d54cc35f2c\", \"compositor_unittests\": \"9e0d6559ace2ec66fbef2f3c0c98a0e1c5b7afa5\", \"content_browsertests\": \"c566258c9ff5bea64daab857f4934609ee0e819f\", \"content_unittests\": \"9384bdd9dcaf41203064e43e4451b3f2306851d8\", \"courgette_unittests\": \"9255ed270c746a4277c076afb8e4ecc0765a665e\", \"crashpad_tests\": \"505482293273a34ff74cf1fe369e89dbddb15977\", \"cronet_tests\": \"42306de6bc0a9e370d0af711b6144b02d405132a\", \"cronet_unittests\": \"baedfee418e3573dbbd2715ef8071caf00e0008d\", \"crypto_unittests\": \"c48cfbbd3fe8af209aefad43c9d29265df725895\", \"delayloads_unittests\": \"0b31f1737cb6a64b97ea9f77d021c42ce23183de\", \"device_unittests\": \"d9adacde58c5e14bf74301d8b61f74b4c6df37c9\", \"display_unittests\": \"836435689115e888e8e754da3d30d1c3c45a973a\", \"elevation_service_unittests\": \"4d92ec9f60d0a1d46b97637d0e57776fe6888017\", \"events_unittests\": \"3930ae0ecaa43212f8450410a160da7d31ce88ab\", \"extensions_browsertests\": \"3ddae2f36a79cc6b76be132d00e7a6fcfbf9273d\", \"extensions_unittests\": \"7eb1cfb5a6ebbe85ebf1ce95a283b04c31e94f5d\", \"filesystem_service_unittests\": \"ad643e4ab3e0696cce39bd415a38d0fab5220f9d\", \"gcm_unit_tests\": \"b0deca97d69190e6aca43b3a5f492dd1079017f0\", \"gcp_unittests\": \"08dd6a1d4432564a1543fc9017d4cb9de0dfcf1a\", \"gfx_unittests\": \"91377adef8243d603c1a01e6fb855a0d8b7d62f5\", \"gin_unittests\": \"5c8676576952783539fcd131b2c5dc414c968779\", \"google_apis_unittests\": \"41881818b2892b29f7f3a7a7edc28fc8a5b1c18d\", \"gpu_unittests\": \"2783fdf4cbf351d7b35f574f38bc35d19a0bab60\", \"gwp_asan_unittests\": \"4ee736f8e9eb3049d0288af289c5b9b8a75d030f\", \"headless_browsertests\": \"f2cd5b2dfda73492124f6f1b0f76b78b6ed08d50\", \"headless_unittests\": \"118e262ed5933dfad3c4a99ae8c7b4eea24c4a00\", \"install_static_unittests\": \"dbe67ad51cbd2c5819bbb6f002b027aa1114b09d\", \"installer_util_unittests\": \"eca80f2e0a9608636baf80ed843793bdda775403\", \"interactive_ui_tests\": \"44b92e9a452d470ae6c71750d73d4090bdd715e1\", \"ipc_tests\": \"99e2c4ff9f7e7e28456f14bcdd517f543d012247\", \"jingle_unittests\": \"4e2ea3dc24fedde9df01f8afe5ca0c99832df9a0\", \"latency_unittests\": \"931d8fb034729e49788a8fd4ea456f1e47ecdc21\", \"libjingle_xmpp_unittests\": \"2ca994cb2da85c1c6fd970340d7618f54a90e9c3\", \"liburlpattern_unittests\": \"e83204cc574022d43bc66ff187ae4be4bfd1d3a0\", \"media_blink_unittests\": \"ac60f9340dba53c11bb4ed4fc4adf2425cbb45fb\", \"media_unittests\": \"f8ee6843c328ea3681c5980f55c746185cc26fec\", \"message_center_unittests\": \"eaa24098f5fd11a1ce17b30875e4e77d137d4252\", \"midi_unittests\": \"135cf2ff92e76ecc53e8ac69eb28f006ba502668\", \"mojo_core_unittests\": \"19501930761909f9a2dc66e5f038640dca795c62\", \"mojo_unittests\": \"454893f6bad0cb970311cf37f4400547d47f11ca\", \"nacl_loader_unittests\": \"d939f38cae10e04e9f4fa632bb68788d97eef0a5\", \"native_theme_unittests\": \"2aeb22edce837c83d43973488130d8255cab189b\", \"net_unittests\": \"174af46ccf001969f8170a643cf29fcf07e28d7a\", \"notification_helper_unittests\": \"f87d0c376a8225a7da758f31981ffe8d8e4ac844\", \"pdf_unittests\": \"fe8b06e6b6ba0846ae5f5602a8337f91cce5ecda\", \"perfetto_unittests\": \"579be7f61edfec382e75f1d9d552160b7eec9df3\", \"ppapi_unittests\": \"93e155089c1eec1e00ea8ec8ef8a2598ae34a26a\", \"printing_unittests\": \"7c06cd3074dd6548ff0127cea71a74aaa23e28cb\", \"remoting_unittests\": \"d9a60f14a8ba969fefbb9f15d36a0bb24efffcc2\", \"sbox_integration_tests\": \"be56f3e66968a0273b92354c28e94f781ea5c76f\", \"sbox_unittests\": \"ebbdcfed84b280a25f8a8f05ce6b0571b4498c4e\", \"sbox_validation_tests\": \"5b1f6785a0e202c160a932a0d96b671710dc02e9\", \"service_manager_unittests\": \"4ef5ea12c61b5c292165517c91196e9bfe53bcc2\", \"services_unittests\": \"78fff203c917e7822e20dd49bd297a7922cfc125\", \"setup_unittests\": \"77d1c3348b4cbbee46ef4e7362d06073810abe66\", \"shell_dialogs_unittests\": \"03905903f49940f6e20764bcebc69780a5ca9305\", \"skia_unittests\": \"b1f97f82a99f1d753607577cecc6241b8c8db941\", \"snapshot_unittests\": \"3c2d750fd0a0ed4cc72a763e1551d879ecca4e15\", \"sql_unittests\": \"b45de565cabf3f41cf03e4f4dcf579a0121ba3a4\", \"storage_unittests\": \"38a6d974cf4f79c0cc9f558fe115865334c1d510\", \"sync_integration_tests\": \"977a89a2a5dee8ec7274efecf9857d5c908f5937\", \"traffic_annotation_auditor_unittests\": \"3f34342a60a5a98b898c5e1a338714f05fa8f51c\", \"ui_base_unittests\": \"a772d8cc7084d4788939088fc69d548bf1393c5d\", \"ui_touch_selection_unittests\": \"0059191c87817f1262e3b72de22480ff7253348a\", \"unit_tests\": \"bc5ef2a9bcde79c9710450f19aa48878cbf292eb\", \"updater_tests\": \"7c1c84b2e98e92035712433a745f54474a63edff\", \"url_unittests\": \"36ba39195cb043b45bc22d4352af6dfd9e6fb6a6\", \"views_unittests\": \"551679797527bd5adef6f95a74b85d0d037b1de5\", \"viz_unittests\": \"36c6b83a71213eb53ba7e3eaddcda22fbf062b62\", \"vr_common_unittests\": \"c2c84a8127fcf4c2cd645acec7f2c3ac3afad1cd\", \"vr_pixeltests\": \"cc8250c78c555bb064cd86f6aacf679fa1470c42\", \"weblayer_browsertests\": \"6ab62ea0857c6a498f803427e1b573e4facecc33\", \"weblayer_unittests\": \"4d7c47c055a4a0a6f9de434a31dcf4b1795fe01b\", \"wm_unittests\": \"9da93daf1401c5d9a74efee0fc252ed6c741df4d\", \"wtf_unittests\": \"e8e79bd56cc764bcd23143fa1574ab8982b6e198\", \"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": "1608839192557656",
"status": "COMPLETED",
"status_changed_ts": "1608842498237574",
"tags": [
"build_address:luci.chromium.ci/win-asan/16428",
"builder:win-asan",
"buildset:commit/git/dd424da8616d687028029c1879ebfdb5b0f1d752",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd424da8616d687028029c1879ebfdb5b0f1d752",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025433615506184496",
"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/8860003553335214208/+/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:50af1b62081acd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608842498299865",
"url": "https://ci.chromium.org/b/8860003553335214208",
"utcnow_ts": "1608842500867441"
}
}
[20:41:40.875] Invocation finished in 55m12.205666021s with status SUCCEEDED