[09:45:43.268] New invocation is queued and will start shortly
[09:45:44.418] Starting the invocation (attempt 1)
[09:45:44.456] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:45:44.456] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:45:44.456] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024203054336498304",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1f835bd62049ec5f6b840012972b6251e03feef4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9024203054336498304",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/1f835bd62049ec5f6b840012972b6251e03feef4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1f835bd62049ec5f6b840012972b6251e03feef4",
"gitiles_ref:refs/heads/master"
]
}
[09:45:45.093] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610012744533130",
"id": "8858772992346534864",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1f835bd62049ec5f6b840012972b6251e03feef4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610012744953489",
"tags": [
"build_address:luci.chromium.ci/win-asan/16670",
"builder:win-asan",
"buildset:commit/git/1f835bd62049ec5f6b840012972b6251e03feef4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1f835bd62049ec5f6b840012972b6251e03feef4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024203054336498304",
"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/8858772992346534864/+/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": "1610012744953608",
"url": "https://ci.chromium.org/b/8858772992346534864",
"utcnow_ts": "1610012745082366"
}
}
[09:45:45.093] Task URL: https://ci.chromium.org/b/8858772992346534864
[09:45:45.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:2:0) after 1m0s
[09:45:46.679] Received PubSub notification, asking Buildbucket for the build status
[09:45:46.759] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:45.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:2:0)
[09:46:45.135] Timer tick, asking Buildbucket for the build status
[09:46:45.594] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:45.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:4:0) after 1m0s
[09:47:45.616] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:4:0)
[09:47:45.616] Timer tick, asking Buildbucket for the build status
[09:47:45.733] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:45.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:5:0) after 1m0s
[09:48:45.781] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:5:0)
[09:48:45.781] Timer tick, asking Buildbucket for the build status
[09:48:45.865] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:45.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:6:0) after 1m0s
[09:49:45.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:6:0)
[09:49:45.896] Timer tick, asking Buildbucket for the build status
[09:49:46.198] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:46.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:7:0) after 1m0s
[09:50:46.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:7:0)
[09:50:46.218] Timer tick, asking Buildbucket for the build status
[09:50:46.382] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:46.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:8:0) after 1m0s
[09:51:46.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:8:0)
[09:51:46.408] Timer tick, asking Buildbucket for the build status
[09:51:46.455] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:46.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:9:0) after 1m0s
[09:52:46.479] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:9:0)
[09:52:46.479] Timer tick, asking Buildbucket for the build status
[09:52:46.551] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:46.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:10:0) after 1m0s
[09:53:46.603] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:10:0)
[09:53:46.603] Timer tick, asking Buildbucket for the build status
[09:53:46.668] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:46.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:11:0) after 1m0s
[09:54:46.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:11:0)
[09:54:46.703] Timer tick, asking Buildbucket for the build status
[09:54:46.766] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:46.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:12:0) after 1m0s
[09:55:46.776] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:12:0)
[09:55:46.776] Timer tick, asking Buildbucket for the build status
[09:55:46.855] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:46.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:13:0) after 1m0s
[09:56:46.928] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:13:0)
[09:56:46.928] Timer tick, asking Buildbucket for the build status
[09:56:47.108] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:47.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:14:0) after 1m0s
[09:57:47.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:14:0)
[09:57:47.224] Timer tick, asking Buildbucket for the build status
[09:57:47.378] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:47.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:15:0) after 1m0s
[09:58:47.406] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:15:0)
[09:58:47.406] Timer tick, asking Buildbucket for the build status
[09:58:47.481] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:47.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:16:0) after 1m0s
[09:59:47.538] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:16:0)
[09:59:47.538] Timer tick, asking Buildbucket for the build status
[09:59:47.598] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:47.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:17:0) after 1m0s
[10:00:47.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:17:0)
[10:00:47.731] Timer tick, asking Buildbucket for the build status
[10:00:47.844] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:47.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:18:0) after 1m0s
[10:01:47.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:18:0)
[10:01:47.971] Timer tick, asking Buildbucket for the build status
[10:01:48.081] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:48.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:19:0) after 1m0s
[10:02:48.172] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:19:0)
[10:02:48.172] Timer tick, asking Buildbucket for the build status
[10:02:48.419] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:48.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:20:0) after 1m0s
[10:03:48.491] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:20:0)
[10:03:48.491] Timer tick, asking Buildbucket for the build status
[10:03:48.609] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:48.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:21:0) after 1m0s
[10:04:48.752] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:21:0)
[10:04:48.752] Timer tick, asking Buildbucket for the build status
[10:04:48.882] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:48.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:22:0) after 1m0s
[10:05:48.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:22:0)
[10:05:48.978] Timer tick, asking Buildbucket for the build status
[10:05:49.117] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:49.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:23:0) after 1m0s
[10:06:49.161] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:23:0)
[10:06:49.161] Timer tick, asking Buildbucket for the build status
[10:06:49.281] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:49.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:24:0) after 1m0s
[10:07:49.285] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:24:0)
[10:07:49.285] Timer tick, asking Buildbucket for the build status
[10:07:49.471] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:49.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:25:0) after 1m0s
[10:08:49.462] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:25:0)
[10:08:49.462] Timer tick, asking Buildbucket for the build status
[10:08:49.610] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:49.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:26:0) after 1m0s
[10:09:49.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:26:0)
[10:09:49.662] Timer tick, asking Buildbucket for the build status
[10:09:50.553] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:50.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:27:0) after 1m0s
[10:10:50.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:27:0)
[10:10:50.577] Timer tick, asking Buildbucket for the build status
[10:10:50.700] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:50.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:28:0) after 1m0s
[10:11:50.799] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:28:0)
[10:11:50.799] Timer tick, asking Buildbucket for the build status
[10:11:50.908] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:50.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:29:0) after 1m0s
[10:12:51.018] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:29:0)
[10:12:51.019] Timer tick, asking Buildbucket for the build status
[10:12:51.204] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:51.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:30:0) after 1m0s
[10:13:51.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:30:0)
[10:13:51.302] Timer tick, asking Buildbucket for the build status
[10:13:51.466] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:51.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:31:0) after 1m0s
[10:14:51.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:31:0)
[10:14:51.535] Timer tick, asking Buildbucket for the build status
[10:14:51.984] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:51.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:32:0) after 1m0s
[10:15:52.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:32:0)
[10:15:52.165] Timer tick, asking Buildbucket for the build status
[10:15:52.290] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:52.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:33:0) after 1m0s
[10:16:52.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:33:0)
[10:16:52.304] Timer tick, asking Buildbucket for the build status
[10:16:52.412] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:52.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:34:0) after 1m0s
[10:17:52.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:34:0)
[10:17:52.453] Timer tick, asking Buildbucket for the build status
[10:17:52.551] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:52.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:35:0) after 1m0s
[10:18:52.602] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:35:0)
[10:18:52.602] Timer tick, asking Buildbucket for the build status
[10:18:52.904] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:52.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:36:0) after 1m0s
[10:19:52.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:36:0)
[10:19:52.920] Timer tick, asking Buildbucket for the build status
[10:19:53.025] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:53.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:37:0) after 1m0s
[10:20:53.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:37:0)
[10:20:53.212] Timer tick, asking Buildbucket for the build status
[10:20:53.443] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:53.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:38:0) after 1m0s
[10:21:53.490] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:38:0)
[10:21:53.490] Timer tick, asking Buildbucket for the build status
[10:21:53.696] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:53.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:39:0) after 1m0s
[10:22:53.719] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:39:0)
[10:22:53.719] Timer tick, asking Buildbucket for the build status
[10:22:53.862] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:53.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:40:0) after 1m0s
[10:23:53.912] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:40:0)
[10:23:53.912] Timer tick, asking Buildbucket for the build status
[10:23:54.262] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:54.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:41:0) after 1m0s
[10:24:54.289] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:41:0)
[10:24:54.289] Timer tick, asking Buildbucket for the build status
[10:24:54.374] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:54.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:42:0) after 1m0s
[10:25:54.450] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:42:0)
[10:25:54.450] Timer tick, asking Buildbucket for the build status
[10:25:54.572] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:54.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:43:0) after 1m0s
[10:26:54.611] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:43:0)
[10:26:54.611] Timer tick, asking Buildbucket for the build status
[10:26:54.682] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:54.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:44:0) after 1m0s
[10:27:54.832] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:44:0)
[10:27:54.832] Timer tick, asking Buildbucket for the build status
[10:27:54.900] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:54.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:45:0) after 1m0s
[10:28:55.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:45:0)
[10:28:55.043] Timer tick, asking Buildbucket for the build status
[10:28:57.122] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:57.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:46:0) after 1m0s
[10:29:57.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:46:0)
[10:29:57.107] Timer tick, asking Buildbucket for the build status
[10:30:00.209] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:00.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:47:0) after 1m0s
[10:31:00.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:47:0)
[10:31:00.283] Timer tick, asking Buildbucket for the build status
[10:31:01.103] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:01.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:48:0) after 1m0s
[10:32:01.812] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:48:0)
[10:32:01.812] Timer tick, asking Buildbucket for the build status
[10:32:01.951] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:01.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:49:0) after 1m0s
[10:33:02.088] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:49:0)
[10:33:02.088] Timer tick, asking Buildbucket for the build status
[10:33:02.194] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:02.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:50:0) after 1m0s
[10:34:02.221] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:50:0)
[10:34:02.221] Timer tick, asking Buildbucket for the build status
[10:34:02.332] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:02.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:51:0) after 1m0s
[10:35:02.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:51:0)
[10:35:02.413] Timer tick, asking Buildbucket for the build status
[10:35:02.707] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:02.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:52:0) after 1m0s
[10:36:02.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:52:0)
[10:36:02.695] Timer tick, asking Buildbucket for the build status
[10:36:02.896] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:02.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:53:0) after 1m0s
[10:37:02.952] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:53:0)
[10:37:02.952] Timer tick, asking Buildbucket for the build status
[10:37:03.078] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:03.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:54:0) after 1m0s
[10:38:03.171] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:54:0)
[10:38:03.171] Timer tick, asking Buildbucket for the build status
[10:38:03.336] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:03.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:55:0) after 1m0s
[10:39:03.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:55:0)
[10:39:03.451] Timer tick, asking Buildbucket for the build status
[10:39:03.699] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:03.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:56:0) after 1m0s
[10:40:03.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:56:0)
[10:40:03.797] Timer tick, asking Buildbucket for the build status
[10:40:03.874] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:03.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:57:0) after 1m0s
[10:41:03.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:57:0)
[10:41:03.870] Timer tick, asking Buildbucket for the build status
[10:41:04.011] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:04.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:58:0) after 1m0s
[10:42:04.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:58:0)
[10:42:04.009] Timer tick, asking Buildbucket for the build status
[10:42:04.231] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:04.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:59:0) after 1m0s
[10:43:04.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:59:0)
[10:43:04.260] Timer tick, asking Buildbucket for the build status
[10:43:04.406] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:04.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:60:0) after 1m0s
[10:44:04.464] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:60:0)
[10:44:04.464] Timer tick, asking Buildbucket for the build status
[10:44:04.671] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:04.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:61:0) after 1m0s
[10:45:05.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:61:0)
[10:45:05.024] Timer tick, asking Buildbucket for the build status
[10:45:05.201] Build 8858772992346534864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:05.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024203054336498304:62:0) after 1m0s
[10:45:05.701] Received PubSub notification, asking Buildbucket for the build status
[10:45:05.779] Build 8858772992346534864: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:45:05.779] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610016303690232",
"created_by": "project:chromium",
"created_ts": "1610012744533130",
"id": "8858772992346534864",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1f835bd62049ec5f6b840012972b6251e03feef4\"}}",
"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\": \"1f835bd62049ec5f6b840012972b6251e03feef4\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-7-w73f\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16670, \"clang_revision\": \"llvmorg-12-init-15676-g5c951623-1\", \"got_angle_revision\": \"ca94d1da85979c910be4c185f97f1f1406534634\", \"got_dawn_revision\": \"fac169113df7dad1b55092ab099eabb25e723719\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"1f835bd62049ec5f6b840012972b6251e03feef4\", \"got_revision_cp\": \"refs/heads/master@{#840985}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"7b2f938954180e8945f776d3e202f6a2bda1aaf9\", \"got_v8_revision\": \"8bf25fa0cda754dd0f8e0f8b7c9f8854eabfe72d\", \"got_v8_revision_cp\": \"refs/heads/8.9.213@{#1}\", \"got_webrtc_revision\": \"fc6b87192db6d5e4fd6997814f00b6792cf16180\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32904}\", \"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\": \"1f835bd62049ec5f6b840012972b6251e03feef4\", \"swarm_hashes_refs/heads/master(at){#840985}_without_patch\": {\"absl_hardening_tests\": \"38a39e6cba45e660bb5a99c97df8bf6012401c6c\", \"accessibility_unittests\": \"725459a6bf9492dde415c4ea9fdeda1b261c61f2\", \"angle_unittests\": \"cce9d1453820770b7e9422e8ffbc3ccb37748804\", \"app_shell_unittests\": \"60789c82941c6a0171d4e314bc34bee0b215320c\", \"aura_unittests\": \"1ddd7fd036f45ee837b35c4ffdc7f3b91fa00fda\", \"base_unittests\": \"0c7f3dbe2ad97ecca15aec96aa8c873bcd65570b\", \"base_util_unittests\": \"c6ef132b1bbdcd421cffe5e0651cdb1939bafc18\", \"blink_common_unittests\": \"1a427e3360ea9faf6905ae4743f39f298bb80288\", \"blink_fuzzer_unittests\": \"8b67dd34919a9c5155a0a6d0236be1f83995c3d4\", \"blink_heap_unittests\": \"dd5d4cbd47e35c6fa92cb2c693f04639458d07fc\", \"blink_platform_unittests\": \"32d021c59405a9603e36ec9d3a5d233a71af28b1\", \"blink_unittests\": \"1692934367559670d8fcd6095a6b832d39a62180\", \"boringssl_crypto_tests\": \"a31661495ef160d54491f4037d25332926da9e60\", \"boringssl_ssl_tests\": \"aee64f32ea5d20c7eb47870ca1e0c353da20c654\", \"browser_switcher_bho_unittests\": \"d6bd884e8725cc33245b9696cb2e1a5c5d6e7858\", \"browser_tests\": \"713d27d6511263a75bf3b8229de94c0a79381673\", \"capture_unittests\": \"d5bfb3f035a6b0d408d8189ab77483a97280f20e\", \"cast_unittests\": \"c88cb657178168d3801fb8e445aac66b98265a7e\", \"cc_unittests\": \"20fe20c447c2358a47fa6bc93f8004ab15463559\", \"chrome_app_unittests\": \"a27e810c610351526b84a039884d9e04c95e19c8\", \"chrome_cleaner_unittests\": \"5f878d97bcfda2d468d5f4fc8c5a2cb7802ddf95\", \"chrome_elf_unittests\": \"641c0e2f788a03e4b241f07f8d807d402e231691\", \"chromedriver_unittests\": \"46acf37aa040aeb87d9d98c610da433eb159eb78\", \"components_browsertests\": \"42729a88b85017e4d6e9b696d9787be5e7bc2748\", \"components_unittests\": \"f47b7c2e06a5987202c84b08b731dddda4a51dc2\", \"compositor_unittests\": \"cf747a79675b74e7910597498062ede6410ab45b\", \"content_browsertests\": \"528b205deed7be68a8a1cecbdf6591a2e84e0c55\", \"content_unittests\": \"5fb9fbee979f8e289f8270f8519f732d82265b06\", \"courgette_unittests\": \"c488d504806157ddd3d1fe6b50157cfd1da04526\", \"crashpad_tests\": \"28229f7a48ad733e6330b0fe18842bd54283ff7b\", \"cronet_tests\": \"be300a2675641ee4eb2f79b48579b8b20e773e40\", \"cronet_unittests\": \"dff962ce929e31939c2ef2963387a5ffc694d9a1\", \"crypto_unittests\": \"18e8c4ddd2bfe0093b2e50d08ca55daf59f88acd\", \"delayloads_unittests\": \"7962bb931f9f8908810134a9f8a706cdf18a81dc\", \"device_unittests\": \"7332d3d9ab220a6230404507e849227c5f199080\", \"display_unittests\": \"bebe528faf43404a7eb71f5a0f3aa5b7d538c262\", \"elevation_service_unittests\": \"a9fe6d9e93481897c2f14b93e831eeaf74abeed5\", \"events_unittests\": \"352da6d2d4fb24411c91b289fd5e3c06c444c160\", \"extensions_browsertests\": \"332ca316b5d9343f894b950a211b4dd1cccf9081\", \"extensions_unittests\": \"6fc3c611da7709eb653eaade2f2e25bd201d74b2\", \"filesystem_service_unittests\": \"b85ae7aa67cb88034408f0f1fcc60d0f1c703833\", \"gcm_unit_tests\": \"9d3d31cb1543e7625e83e6a62ab55e2c17b276f2\", \"gcp_unittests\": \"a0fc5a172a690fb18ff2d844a6a30ee40f1ed57d\", \"gfx_unittests\": \"96f4ea8e3f94f01ba77b2ba1b64246425a9748e3\", \"gin_unittests\": \"25ba0fee7cca739933732fd49fffe2a6c4e37e40\", \"google_apis_unittests\": \"c00c63f07417dfc4fcfb81e943b2d6401eefccbe\", \"gpu_unittests\": \"fe42dcf66437baa4ff7111fb36037c8a0133aeb3\", \"gwp_asan_unittests\": \"e6fc52a22fd623787dac3bfc96b6459436766485\", \"headless_browsertests\": \"768604d450899f443fb64b3035a19d2a68e82681\", \"headless_unittests\": \"dba47a09d1c2cef3ac483f046f250d70d5f3e082\", \"install_static_unittests\": \"07bb57060fc607e4970c8f63ded71638e36c3af6\", \"installer_util_unittests\": \"c3d9daca06e9b761bc9dab45ffe7a5e440013e12\", \"interactive_ui_tests\": \"6795f8e9bc72b3bd35afd4fcd9f753308ee236c8\", \"ipc_tests\": \"18fc35597e23baa88a44c698a532274c228c7237\", \"jingle_unittests\": \"f0bfc7c35ceeb8cef9dca3bb1e8c476e5ef2c9b6\", \"latency_unittests\": \"1a2f7b1125f0ba52ee9997d46d9415875436da49\", \"libjingle_xmpp_unittests\": \"4c9c7b392dc681cb01945b005459742f8eb39c10\", \"liburlpattern_unittests\": \"90fd42aa1a128bc84c132ef6d946ed6dec1a4fad\", \"media_blink_unittests\": \"f904b75d2d708b5c8206f9f649f548e085055574\", \"media_unittests\": \"28fe247be6237990e1c6864825a36581a4ba1aa3\", \"message_center_unittests\": \"de78ad1b1fc906417ea51bfb59074f9ff42187d7\", \"midi_unittests\": \"3aa2cbbac415942468eb96113426adbc1a9b7b28\", \"mojo_core_unittests\": \"55ee9045c275167351ddb0f2dd7028818563e83e\", \"mojo_unittests\": \"6a330adf5ac9706a3e84f680d11ddb5380087559\", \"nacl_loader_unittests\": \"35e51e544f918a235063c0421fd12cac5bb2e907\", \"native_theme_unittests\": \"71c22177634849ab6844dece5769a8042df8de23\", \"net_unittests\": \"77f714d07504f7f0b0d8323354ff12eb8e194ee2\", \"notification_helper_unittests\": \"0a646d573a9c4aa8d9bb947b6af5fc9ae544af81\", \"pdf_unittests\": \"23e7d1527fc4397d53538755b33a5647d87a8266\", \"perfetto_unittests\": \"f082152de186334608e114fc3e421c4bac90354f\", \"ppapi_unittests\": \"665f8d9de8afa6b1b19413b1fba5df0d8aaf8820\", \"printing_unittests\": \"593e03fc0b09f1c5fc3af2ac77f4b78a6414ad5a\", \"remoting_unittests\": \"a83cbef95248014134a7632a8007923c23e9cf0d\", \"sbox_integration_tests\": \"7863fa7f37ce957f69194a6a3b8d78972fd99084\", \"sbox_unittests\": \"04a376f2c0598bbec8907fe8b16b0790343b653c\", \"sbox_validation_tests\": \"338a234ab3b6cbcce0313eb51cfdc5b0ed22571f\", \"service_manager_unittests\": \"ae2f22e5ed85070b2fbee68fd68242f93f2af676\", \"services_unittests\": \"80bcdf6b6bcd57ebfcc0c5ec96db6898e67119f1\", \"setup_unittests\": \"212d57c86c4b44285782ced7692fe2df2ddcda95\", \"shell_dialogs_unittests\": \"e5f31e3c5c4a2fc7c76fb2836421233b823df9c8\", \"skia_unittests\": \"229d95b2cc57794ff7c5193f2b8f13fa2c0d0215\", \"snapshot_unittests\": \"bff5ae57110fc9a75e387e315b0793645d9d64cf\", \"sql_unittests\": \"6e09365581cc7485478e9720770e4bf535958bf4\", \"storage_unittests\": \"034a77b4a3891452b4066bb2d3e2dc7aa2644f87\", \"sync_integration_tests\": \"a655793c2629b30ebe3f4964b9d15a8d588f5e8a\", \"traffic_annotation_auditor_unittests\": \"1576f91c16c8651f524eb40a74812076fbb15d2e\", \"ui_base_unittests\": \"1f33acd519505f4ec61ad542ccd7cf5d5794cb3c\", \"ui_touch_selection_unittests\": \"810bc26870f2d7ba5b37deb3cdddb4db1a2eb2bf\", \"unit_tests\": \"f69669b6a470fdcb610ff3f5b3cef73b375caa4c\", \"updater_tests\": \"9eed51fdfd4af1c45ac25f79f1059103c3e5d4f7\", \"url_unittests\": \"a7eab7fbec91cbe18dab9a3a96d7b2569663a761\", \"views_unittests\": \"478768bee4aa056dd69590457eff9738960288e2\", \"viz_unittests\": \"d4c4a91e5c688c24ff3d6d3c743c22777a723a84\", \"vr_common_unittests\": \"63283e8788cf2138244d7d594faa1de10d082d26\", \"vr_pixeltests\": \"22b612510a8280e2501ca7e011184076b27b876c\", \"weblayer_browsertests\": \"12576801e6c5c70aa3a032b40675ef18e5029f49\", \"weblayer_unittests\": \"3c809b6b1cec21440eae9948a4492ffc1188e712\", \"wm_unittests\": \"733d96cd6957af3f074bdb52aa95447a074a50d0\", \"wtf_unittests\": \"749713dfb9a26aa69b6ec0eb0c1a85048578de40\", \"zlib_unittests\": \"97b62567050a8a7ef56124d2d86b9ecdfd91573f\", \"zucchini_unittests\": \"7bb7e1683af68d0ecb49e35fb10e55fcb7fdd830\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-7-w73f\"], \"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-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610012746024746",
"status": "COMPLETED",
"status_changed_ts": "1610016304744882",
"tags": [
"build_address:luci.chromium.ci/win-asan/16670",
"builder:win-asan",
"buildset:commit/git/1f835bd62049ec5f6b840012972b6251e03feef4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1f835bd62049ec5f6b840012972b6251e03feef4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024203054336498304",
"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/8858772992346534864/+/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:50f50e6636873110",
"user_agent:luci-scheduler"
],
"updated_ts": "1610016304809640",
"url": "https://ci.chromium.org/b/8858772992346534864",
"utcnow_ts": "1610016305765896"
}
}
[10:45:05.779] Invocation finished in 59m22.527421049s with status SUCCEEDED