[05:53:36.661] New invocation is queued and will start shortly
[05:53:37.894] Starting the invocation (attempt 1)
[05:53:37.935] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:53:37.935] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:53:37.935] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028022730032299744",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e3600e5af2e8682d645f5c454485beec26f3bfd4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028022730032299744",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/e3600e5af2e8682d645f5c454485beec26f3bfd4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e3600e5af2e8682d645f5c454485beec26f3bfd4",
"gitiles_ref:refs/heads/master"
]
}
[05:53:39.139] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606370018575145",
"id": "8862592667360818112",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e3600e5af2e8682d645f5c454485beec26f3bfd4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606370019011979",
"tags": [
"build_address:luci.chromium.ci/win-asan/15856",
"builder:win-asan",
"buildset:commit/git/e3600e5af2e8682d645f5c454485beec26f3bfd4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e3600e5af2e8682d645f5c454485beec26f3bfd4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028022730032299744",
"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/8862592667360818112/+/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": "1606370019012115",
"url": "https://ci.chromium.org/b/8862592667360818112",
"utcnow_ts": "1606370019129755"
}
}
[05:53:39.140] Task URL: https://ci.chromium.org/b/8862592667360818112
[05:53:39.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:2:0) after 1m0s
[05:53:41.685] Received PubSub notification, asking Buildbucket for the build status
[05:53:41.771] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:39.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:2:0)
[05:54:39.226] Timer tick, asking Buildbucket for the build status
[05:54:39.338] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:39.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:4:0) after 1m0s
[05:55:39.430] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:4:0)
[05:55:39.430] Timer tick, asking Buildbucket for the build status
[05:55:39.540] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:39.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:5:0) after 1m0s
[05:56:39.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:5:0)
[05:56:39.536] Timer tick, asking Buildbucket for the build status
[05:56:39.859] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:39.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:6:0) after 1m0s
[05:57:39.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:6:0)
[05:57:39.909] Timer tick, asking Buildbucket for the build status
[05:57:40.004] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:40.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:7:0) after 1m0s
[05:58:40.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:7:0)
[05:58:40.066] Timer tick, asking Buildbucket for the build status
[05:58:40.182] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:40.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:8:0) after 1m0s
[05:59:40.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:8:0)
[05:59:40.246] Timer tick, asking Buildbucket for the build status
[05:59:40.429] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:40.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:9:0) after 1m0s
[06:00:40.416] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:9:0)
[06:00:40.416] Timer tick, asking Buildbucket for the build status
[06:00:40.663] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:40.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:10:0) after 1m0s
[06:01:41.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:10:0)
[06:01:41.981] Timer tick, asking Buildbucket for the build status
[06:01:42.055] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:42.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:11:0) after 1m0s
[06:02:42.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:11:0)
[06:02:42.392] Timer tick, asking Buildbucket for the build status
[06:02:42.467] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:42.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:12:0) after 1m0s
[06:03:42.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:12:0)
[06:03:42.662] Timer tick, asking Buildbucket for the build status
[06:03:42.921] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:42.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:13:0) after 1m0s
[06:04:42.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:13:0)
[06:04:42.925] Timer tick, asking Buildbucket for the build status
[06:04:43.181] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:43.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:14:0) after 1m0s
[06:05:43.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:14:0)
[06:05:43.230] Timer tick, asking Buildbucket for the build status
[06:05:43.957] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:43.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:15:0) after 1m0s
[06:06:44.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:15:0)
[06:06:44.067] Timer tick, asking Buildbucket for the build status
[06:06:44.200] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:44.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:16:0) after 1m0s
[06:07:44.187] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:16:0)
[06:07:44.187] Timer tick, asking Buildbucket for the build status
[06:07:44.501] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:44.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:17:0) after 1m0s
[06:08:44.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:17:0)
[06:08:44.641] Timer tick, asking Buildbucket for the build status
[06:08:44.801] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:44.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:18:0) after 1m0s
[06:09:44.894] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:18:0)
[06:09:44.894] Timer tick, asking Buildbucket for the build status
[06:09:45.009] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:45.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:19:0) after 1m0s
[06:10:45.096] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:19:0)
[06:10:45.096] Timer tick, asking Buildbucket for the build status
[06:10:45.210] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:45.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:20:0) after 1m0s
[06:11:45.250] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:20:0)
[06:11:45.250] Timer tick, asking Buildbucket for the build status
[06:11:45.410] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:45.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:21:0) after 1m0s
[06:12:45.473] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:21:0)
[06:12:45.473] Timer tick, asking Buildbucket for the build status
[06:12:46.023] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:46.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:22:0) after 1m0s
[06:13:46.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:22:0)
[06:13:46.097] Timer tick, asking Buildbucket for the build status
[06:13:46.198] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:46.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:23:0) after 1m0s
[06:14:46.221] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:23:0)
[06:14:46.221] Timer tick, asking Buildbucket for the build status
[06:14:46.321] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:46.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:24:0) after 1m0s
[06:15:46.345] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:24:0)
[06:15:46.345] Timer tick, asking Buildbucket for the build status
[06:15:46.470] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:46.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:25:0) after 1m0s
[06:16:46.555] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:25:0)
[06:16:46.555] Timer tick, asking Buildbucket for the build status
[06:16:46.660] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:46.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:26:0) after 1m0s
[06:17:46.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:26:0)
[06:17:46.785] Timer tick, asking Buildbucket for the build status
[06:17:46.964] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:46.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:27:0) after 1m0s
[06:18:47.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:27:0)
[06:18:47.035] Timer tick, asking Buildbucket for the build status
[06:18:47.166] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:47.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:28:0) after 1m0s
[06:19:47.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:28:0)
[06:19:47.200] Timer tick, asking Buildbucket for the build status
[06:19:47.932] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:47.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:29:0) after 1m0s
[06:20:47.935] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:29:0)
[06:20:47.935] Timer tick, asking Buildbucket for the build status
[06:20:48.298] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:48.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:30:0) after 1m0s
[06:21:48.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:30:0)
[06:21:48.654] Timer tick, asking Buildbucket for the build status
[06:21:48.750] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:48.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:31:0) after 1m0s
[06:22:49.012] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:31:0)
[06:22:49.012] Timer tick, asking Buildbucket for the build status
[06:22:49.514] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:49.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:32:0) after 1m0s
[06:23:49.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:32:0)
[06:23:49.574] Timer tick, asking Buildbucket for the build status
[06:23:50.146] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:50.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:33:0) after 1m0s
[06:24:50.208] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:33:0)
[06:24:50.208] Timer tick, asking Buildbucket for the build status
[06:24:50.930] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:50.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:34:0) after 1m0s
[06:25:51.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:34:0)
[06:25:51.078] Timer tick, asking Buildbucket for the build status
[06:25:51.503] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:51.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:35:0) after 1m0s
[06:26:51.664] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:35:0)
[06:26:51.664] Timer tick, asking Buildbucket for the build status
[06:26:51.786] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:51.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:36:0) after 1m0s
[06:27:51.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:36:0)
[06:27:51.921] Timer tick, asking Buildbucket for the build status
[06:27:52.025] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:52.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:37:0) after 1m0s
[06:28:52.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:37:0)
[06:28:52.047] Timer tick, asking Buildbucket for the build status
[06:28:52.152] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:52.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:38:0) after 1m0s
[06:29:52.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:38:0)
[06:29:52.205] Timer tick, asking Buildbucket for the build status
[06:29:52.273] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:52.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:39:0) after 1m0s
[06:30:52.405] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:39:0)
[06:30:52.405] Timer tick, asking Buildbucket for the build status
[06:30:52.488] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:52.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:40:0) after 1m0s
[06:31:52.851] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:40:0)
[06:31:52.851] Timer tick, asking Buildbucket for the build status
[06:31:53.223] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:53.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:41:0) after 1m0s
[06:32:53.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:41:0)
[06:32:53.286] Timer tick, asking Buildbucket for the build status
[06:32:53.388] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:53.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:42:0) after 1m0s
[06:33:53.502] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:42:0)
[06:33:53.502] Timer tick, asking Buildbucket for the build status
[06:33:53.887] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:53.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:43:0) after 1m0s
[06:34:53.946] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:43:0)
[06:34:53.946] Timer tick, asking Buildbucket for the build status
[06:34:54.075] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:54.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:44:0) after 1m0s
[06:35:54.137] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:44:0)
[06:35:54.137] Timer tick, asking Buildbucket for the build status
[06:35:54.436] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:54.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:45:0) after 1m0s
[06:36:54.477] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:45:0)
[06:36:54.477] Timer tick, asking Buildbucket for the build status
[06:36:54.955] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:54.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:46:0) after 1m0s
[06:37:55.397] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:46:0)
[06:37:55.397] Timer tick, asking Buildbucket for the build status
[06:37:55.464] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:55.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:47:0) after 1m0s
[06:38:55.893] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:47:0)
[06:38:55.893] Timer tick, asking Buildbucket for the build status
[06:38:56.000] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:56.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:48:0) after 1m0s
[06:39:56.187] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:48:0)
[06:39:56.187] Timer tick, asking Buildbucket for the build status
[06:39:56.299] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:56.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:49:0) after 1m0s
[06:40:56.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:49:0)
[06:40:56.454] Timer tick, asking Buildbucket for the build status
[06:40:56.625] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:56.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:50:0) after 1m0s
[06:41:56.709] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:50:0)
[06:41:56.709] Timer tick, asking Buildbucket for the build status
[06:41:56.790] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:56.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:51:0) after 1m0s
[06:42:56.926] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:51:0)
[06:42:56.926] Timer tick, asking Buildbucket for the build status
[06:42:57.168] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:57.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:52:0) after 1m0s
[06:43:57.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:52:0)
[06:43:57.321] Timer tick, asking Buildbucket for the build status
[06:43:57.420] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:57.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:53:0) after 1m0s
[06:44:57.486] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:53:0)
[06:44:57.486] Timer tick, asking Buildbucket for the build status
[06:44:57.648] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:57.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:54:0) after 1m0s
[06:45:57.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:54:0)
[06:45:57.668] Timer tick, asking Buildbucket for the build status
[06:45:58.087] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:58.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:55:0) after 1m0s
[06:46:58.201] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:55:0)
[06:46:58.201] Timer tick, asking Buildbucket for the build status
[06:46:58.395] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:58.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:56:0) after 1m0s
[06:47:58.404] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:56:0)
[06:47:58.404] Timer tick, asking Buildbucket for the build status
[06:47:58.495] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:58.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:57:0) after 1m0s
[06:48:58.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:57:0)
[06:48:58.572] Timer tick, asking Buildbucket for the build status
[06:48:58.748] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:58.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:58:0) after 1m0s
[06:49:58.766] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:58:0)
[06:49:58.766] Timer tick, asking Buildbucket for the build status
[06:49:58.833] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:58.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:59:0) after 1m0s
[06:50:58.857] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:59:0)
[06:50:58.857] Timer tick, asking Buildbucket for the build status
[06:50:58.972] Build 8862592667360818112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:58.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028022730032299744:60:0) after 1m0s
[06:51:22.478] Received PubSub notification, asking Buildbucket for the build status
[06:51:22.685] Build 8862592667360818112: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:51:22.685] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606373481762993",
"created_by": "project:chromium",
"created_ts": "1606370018575145",
"id": "8862592667360818112",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e3600e5af2e8682d645f5c454485beec26f3bfd4\"}}",
"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\": \"e3600e5af2e8682d645f5c454485beec26f3bfd4\", \"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-6-2gr3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15856, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"939fcd1a14f5ddc43e300bcb2d5d1f680c50ab85\", \"got_dawn_revision\": \"9175f00eec91c6c9b3c3e264d6d8ec7879881844\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"e3600e5af2e8682d645f5c454485beec26f3bfd4\", \"got_revision_cp\": \"refs/heads/master@{#831265}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"fe46597df7664f8fe317c2363cfad28007283e75\", \"got_v8_revision_cp\": \"refs/heads/8.9.53@{#1}\", \"got_webrtc_revision\": \"b6b599fc588e59142df343d2d2897203468aacea\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32695}\", \"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\": \"e3600e5af2e8682d645f5c454485beec26f3bfd4\", \"swarm_hashes_refs/heads/master(at){#831265}_without_patch\": {\"absl_hardening_tests\": \"4918cbf3c3edab1c87acb76a873882c9292f27b4\", \"accessibility_unittests\": \"4b13c3d9cad5a01229e8a606015f3698327a507c\", \"angle_unittests\": \"a3af58276b6c5b2ebce836e856487295928489c6\", \"app_shell_unittests\": \"988b2d8bb36262e12508810b759cb6afe7c9a970\", \"aura_unittests\": \"1d7c45e81a41c1f15a3b451b8b46ff29fbce97a2\", \"base_unittests\": \"dce2ab616f102b6d908d6038d836d1bdf3fe2212\", \"base_util_unittests\": \"f2faad506e8960d05b5a556e4601ca50481753c0\", \"blink_common_unittests\": \"e0f51dd567d1ed908739edccbf2bc4a5b242e7ff\", \"blink_fuzzer_unittests\": \"2926e01f050586ace845408d08918c05b40f76ba\", \"blink_heap_unittests\": \"a231a2474ac83788aca2832b5a257d7036e58c44\", \"blink_platform_unittests\": \"952a0da0a9052f54e0409684b202de2acb17c865\", \"blink_unittests\": \"06a1e8a7f8308715e03a72f85b8b89de95d61c17\", \"boringssl_crypto_tests\": \"0e827e55fc4e902fa13394e2f03e33411768509b\", \"boringssl_ssl_tests\": \"f5bafeaad5a9507e0f4a3d43b17cad33e6abed40\", \"browser_switcher_bho_unittests\": \"a5bb0313c3a39326e0b81dcd07d392ff5108f11d\", \"browser_tests\": \"d9965f656a28f1465a639472411f1448f6caac8e\", \"capture_unittests\": \"b5807b6140f242377dd5851441047e810f9b0b64\", \"cast_unittests\": \"60ab9ae09f2a0dce3547329b04817e461376a5ee\", \"cc_unittests\": \"e58ea824c08e8f05d7ad33b0a426b1f075b1708b\", \"chrome_app_unittests\": \"b4d8da07b617ca75289863ecdb0154ca19208bab\", \"chrome_cleaner_unittests\": \"0391ab25849c1ba174255a8992320a82468a9447\", \"chrome_elf_unittests\": \"213b540830873fbbe7aa99c8e3a6264bc12b2b77\", \"chromedriver_unittests\": \"45e76a52f8788061b41a6210f9a5a0ff9487474e\", \"components_browsertests\": \"511aba7e7f8e977c58a0764dce8433001f530cf9\", \"components_unittests\": \"237c74769dd14879bdcbb428752565313da2c49a\", \"compositor_unittests\": \"c3ee2f688183a7746fc449b1a05cfb454253e69b\", \"content_browsertests\": \"4b44c4890e21d19ee5e62a4ec0ed3126c354dea1\", \"content_unittests\": \"9a80f74b38ac9099dfdab4becf161755d7865c35\", \"courgette_unittests\": \"284223375255c857f179d5b5d744b7d8c7e0a7da\", \"crashpad_tests\": \"4911d21512ce5f37058f487327aac13a35b0f9b0\", \"cronet_tests\": \"54b472d33e8451fa4f3257aba70ce09fc49f8a87\", \"cronet_unittests\": \"1bf70783610d4292df3233518fc3519c004f4573\", \"crypto_unittests\": \"b60c8b269ab5cbd5d16515aed6b5c6eb80a9d8cf\", \"delayloads_unittests\": \"43f092a3fc883c38557fdf29aa542c1e67cebb1f\", \"device_unittests\": \"bdc0e749e199ac7a3b7eee76b8a98c04f44179cf\", \"display_unittests\": \"225e36de29502813bad96ea5d23f52684d71cb81\", \"elevation_service_unittests\": \"0af6dc17f5ee83ea2fd101399b2abe1b45e2a557\", \"events_unittests\": \"983242a3f4f6a91aeb9e6556bf09697d1a3ab7d0\", \"extensions_browsertests\": \"ee85647fffa73d59afa73e7f86c63285b881a294\", \"extensions_unittests\": \"bf496d037feca26a92cf0ee96f02748703c0fa75\", \"filesystem_service_unittests\": \"a9f9e7617bccdc1fd98da88c5146c0a3ab9e894e\", \"gcm_unit_tests\": \"292eaa2636eb7b01f2ce57526438dbb5d907b959\", \"gcp_unittests\": \"951dcec3da2f050b18465d74f180a995dfb2b6b7\", \"gfx_unittests\": \"e831af53d5e6e5c4957d68b7e451a532a6612b67\", \"gin_unittests\": \"6a9ba7a2598abbb0b894d2fd43db19839ffe944b\", \"google_apis_unittests\": \"72fea5a3d283115d51f8d1bf86149088caf9ef4d\", \"gpu_unittests\": \"1e9539e0b66bb7ba237608826e06cce7421e3f4b\", \"gwp_asan_unittests\": \"442cc9d9695a33aa9e4b47cfe7691a62ac1cff6a\", \"headless_browsertests\": \"ed83854f39a90f1c7e8cbe6223bd8c39b05bbf06\", \"headless_unittests\": \"f14f73a0c6d40a229f4f8d363b87c5b6b32be30b\", \"install_static_unittests\": \"299d718239d35cbe735db999f57ae89df5fdd449\", \"installer_util_unittests\": \"2eb0cb4fac5bdd6d30c711069acb5432b507f0a9\", \"interactive_ui_tests\": \"12419bae91990ec951d1f3f3b59670d57324b837\", \"ipc_tests\": \"e77ce0d30e157e5ea79679b1aaf0fcce3ced4e53\", \"jingle_unittests\": \"e51b384d307172b60b61299668c783d8849a4e7b\", \"latency_unittests\": \"3cb1d7d395211530310460cf372b0ee1abdac5b4\", \"libjingle_xmpp_unittests\": \"704cdaa97564de191c3e23a624cf82ec1b76436a\", \"liburlpattern_unittests\": \"addd143253a68b70bd267c328dc7b278ce399bdc\", \"media_blink_unittests\": \"06eba9036005d8b7f8ee32d2b62c6d9268a68923\", \"media_unittests\": \"0298ea719fe1c6e0cafddc9c37e43bf46751e78e\", \"message_center_unittests\": \"61811b4439dce3858fcdd236718fee8dd85c4f96\", \"midi_unittests\": \"a3ca27adf3bd4281c1d88b19df3887b3622adaaf\", \"mojo_core_unittests\": \"8f53b1c31ac6bb56abeae484e1c934caadfd284e\", \"mojo_unittests\": \"2b9d4fe54a16251ce8442a84c5cb9ef347c3898d\", \"nacl_loader_unittests\": \"77823d843d572e2c609ae1d530a38ac6ee21b2f3\", \"native_theme_unittests\": \"dee0abba79f7477061ba2665084e1f948706a8fe\", \"net_unittests\": \"5308ab86ed24ecf29c35a2938281e119cc260b3a\", \"notification_helper_unittests\": \"7ad646021446670b78a1662ce46507a2c3ec56ac\", \"pdf_unittests\": \"a907dc7720180febf5f21bda8bdcc2a714c8e695\", \"perfetto_unittests\": \"06cc46c36cb35a66cef349ece22cb4a4df0ae921\", \"ppapi_unittests\": \"1287cdb24696dcef68451627440ee0d169768c6c\", \"printing_unittests\": \"d2ae9548ac7109472956b5084706f4f815168a85\", \"remoting_unittests\": \"087bb90f0239a5c363adc7dfcf8317668b4ac8c4\", \"sbox_integration_tests\": \"3d05f8daa22b372a3695f6bba44e92f9c8ff2146\", \"sbox_unittests\": \"8ced15b44acad9236cb2cc4d34b0c9177a59a510\", \"sbox_validation_tests\": \"e774629355cfe75dc4a60b45f98235534d3c76ce\", \"service_manager_unittests\": \"ab533cb557e6bb46a627906618a48fa59e9b6d98\", \"services_unittests\": \"e529534bbd592c894ca925dd817d0f3dec08d411\", \"setup_unittests\": \"3be1b336d403ef35dd96ce559c66d8dfab4d2454\", \"shell_dialogs_unittests\": \"50c0b0b51605d1a9fc3de3a484945405d7a0ca6b\", \"skia_unittests\": \"fb20072ae27dc163cbbed23750a6baa5696bcb41\", \"snapshot_unittests\": \"c0e2d90baff2072502caaec0e1af1a07fe9cce9c\", \"sql_unittests\": \"b8fc17e2e37ec3f190fc44c2997748515fe1d89e\", \"storage_unittests\": \"dc59fbacf8816f0079bbee40c0a2bfb6c8b074e9\", \"sync_integration_tests\": \"54ea355c005662d04abf051b9b6ce223f12805d6\", \"traffic_annotation_auditor_unittests\": \"722f4c7bbe420316c069fa9428bb68c1ee7218cc\", \"ui_base_unittests\": \"8b90ed17d82fc4ed2d2e8865f0d6a0e7bd3e100b\", \"ui_touch_selection_unittests\": \"a1049f9cb7a0f49d18d7eda7693517c1329134f6\", \"unit_tests\": \"e8e497362e889af9d3a06c7fa421adae85959a62\", \"updater_tests\": \"c2c6a4301397ce5c494e6f25b21815b3f15ce851\", \"url_unittests\": \"df7e2dad1293c323f2e18a0b339b99bbd2ec33f8\", \"views_unittests\": \"1b6ad2d03f38be9e167bf9b5b8376fd69f218006\", \"viz_unittests\": \"6e0c2a081d4d04e9722dc6c6f5877615d0af5a0a\", \"vr_common_unittests\": \"b4811957fd20aca70e6f4e9b34deda3507ab24d8\", \"vr_pixeltests\": \"f894e7469ddd7128bd0645c1e0da93e51df7ab44\", \"weblayer_browsertests\": \"8fc88a1d3a458ae1025bcab5cd1bdc825cad90cd\", \"weblayer_unittests\": \"f4cd494cf620b0d6dc806e5b157e3502b90f2c17\", \"wm_unittests\": \"4e07784d71138fc8503d8a38411f0e184ea8cb6e\", \"wtf_unittests\": \"270a55dfb3d81cd4961e5790691eae1849e1fee4\", \"zlib_unittests\": \"ae081cdc6616c7d5495bc914ec29510c4239628f\", \"zucchini_unittests\": \"431fa5b1301e96b6cba4757387fc4406e0a98d86\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_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-6-2gr3\"], \"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\": [\"5640-d0eb544\"], \"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": "1606370021125192",
"status": "COMPLETED",
"status_changed_ts": "1606373482066013",
"tags": [
"build_address:luci.chromium.ci/win-asan/15856",
"builder:win-asan",
"buildset:commit/git/e3600e5af2e8682d645f5c454485beec26f3bfd4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e3600e5af2e8682d645f5c454485beec26f3bfd4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028022730032299744",
"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/8862592667360818112/+/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:501beecfc2a0e310",
"user_agent:luci-scheduler"
],
"updated_ts": "1606373482070007",
"url": "https://ci.chromium.org/b/8862592667360818112",
"utcnow_ts": "1606373482671392"
}
}
[06:51:22.685] Invocation finished in 57m46.040616485s with status SUCCEEDED