[15:24:09.620] New invocation is queued and will start shortly
[15:24:10.785] Starting the invocation (attempt 1)
[15:24:10.825] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:24:10.825] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:24:10.825] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026990267538882544",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e503e8800b78b0963b06a6c9867aede677da9dda\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9026990267538882544",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/e503e8800b78b0963b06a6c9867aede677da9dda",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e503e8800b78b0963b06a6c9867aede677da9dda",
"gitiles_ref:refs/heads/master"
]
}
[15:24:12.159] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1607354650997430",
"id": "8861560205434340240",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e503e8800b78b0963b06a6c9867aede677da9dda\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607354651904321",
"tags": [
"build_address:luci.chromium.ci/win-asan/16084",
"builder:win-asan",
"buildset:commit/git/e503e8800b78b0963b06a6c9867aede677da9dda",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e503e8800b78b0963b06a6c9867aede677da9dda",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026990267538882544",
"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/8861560205434340240/+/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": "1607354651904493",
"url": "https://ci.chromium.org/b/8861560205434340240",
"utcnow_ts": "1607354652147822"
}
}
[15:24:12.159] Task URL: https://ci.chromium.org/b/8861560205434340240
[15:24:12.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:2:0) after 1m0s
[15:24:14.924] Received PubSub notification, asking Buildbucket for the build status
[15:24:15.008] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:12.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:2:0)
[15:25:12.150] Timer tick, asking Buildbucket for the build status
[15:25:12.276] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:12.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:4:0) after 1m0s
[15:26:12.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:4:0)
[15:26:12.293] Timer tick, asking Buildbucket for the build status
[15:26:14.234] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:14.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:5:0) after 1m0s
[15:27:14.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:5:0)
[15:27:14.319] Timer tick, asking Buildbucket for the build status
[15:27:14.431] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:14.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:6:0) after 1m0s
[15:28:14.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:6:0)
[15:28:14.589] Timer tick, asking Buildbucket for the build status
[15:28:15.011] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:15.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:7:0) after 1m0s
[15:29:15.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:7:0)
[15:29:15.128] Timer tick, asking Buildbucket for the build status
[15:29:15.272] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:15.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:8:0) after 1m0s
[15:30:15.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:8:0)
[15:30:15.370] Timer tick, asking Buildbucket for the build status
[15:30:15.493] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:15.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:9:0) after 1m0s
[15:31:15.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:9:0)
[15:31:15.585] Timer tick, asking Buildbucket for the build status
[15:31:15.733] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:15.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:10:0) after 1m0s
[15:32:15.771] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:10:0)
[15:32:15.771] Timer tick, asking Buildbucket for the build status
[15:32:15.999] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:15.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:11:0) after 1m0s
[15:33:16.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:11:0)
[15:33:16.082] Timer tick, asking Buildbucket for the build status
[15:33:16.149] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:16.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:12:0) after 1m0s
[15:34:16.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:12:0)
[15:34:16.186] Timer tick, asking Buildbucket for the build status
[15:34:16.339] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:16.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:13:0) after 1m0s
[15:35:16.393] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:13:0)
[15:35:16.393] Timer tick, asking Buildbucket for the build status
[15:35:16.659] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:16.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:14:0) after 1m0s
[15:36:16.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:14:0)
[15:36:16.798] Timer tick, asking Buildbucket for the build status
[15:36:16.899] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:16.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:15:0) after 1m0s
[15:37:16.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:15:0)
[15:37:16.920] Timer tick, asking Buildbucket for the build status
[15:37:17.119] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:17.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:16:0) after 1m0s
[15:38:17.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:16:0)
[15:38:17.147] Timer tick, asking Buildbucket for the build status
[15:38:17.279] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:17.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:17:0) after 1m0s
[15:39:17.349] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:17:0)
[15:39:17.349] Timer tick, asking Buildbucket for the build status
[15:39:17.525] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:17.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:18:0) after 1m0s
[15:40:17.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:18:0)
[15:40:17.536] Timer tick, asking Buildbucket for the build status
[15:40:17.679] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:17.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:19:0) after 1m0s
[15:41:17.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:19:0)
[15:41:17.670] Timer tick, asking Buildbucket for the build status
[15:41:18.152] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:18.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:20:0) after 1m0s
[15:42:18.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:20:0)
[15:42:18.130] Timer tick, asking Buildbucket for the build status
[15:42:18.294] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:18.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:21:0) after 1m0s
[15:43:18.322] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:21:0)
[15:43:18.322] Timer tick, asking Buildbucket for the build status
[15:43:18.466] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:18.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:22:0) after 1m0s
[15:44:18.518] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:22:0)
[15:44:18.518] Timer tick, asking Buildbucket for the build status
[15:44:19.117] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:19.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:23:0) after 1m0s
[15:45:19.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:23:0)
[15:45:19.159] Timer tick, asking Buildbucket for the build status
[15:45:19.893] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:19.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:24:0) after 1m0s
[15:46:19.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:24:0)
[15:46:19.886] Timer tick, asking Buildbucket for the build status
[15:46:20.026] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:20.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:25:0) after 1m0s
[15:47:20.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:25:0)
[15:47:20.094] Timer tick, asking Buildbucket for the build status
[15:47:20.271] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:20.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:26:0) after 1m0s
[15:48:20.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:26:0)
[15:48:20.341] Timer tick, asking Buildbucket for the build status
[15:48:20.565] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:20.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:27:0) after 1m0s
[15:49:20.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:27:0)
[15:49:20.604] Timer tick, asking Buildbucket for the build status
[15:49:20.758] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:20.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:28:0) after 1m0s
[15:50:20.974] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:28:0)
[15:50:20.974] Timer tick, asking Buildbucket for the build status
[15:50:21.045] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:21.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:29:0) after 1m0s
[15:51:21.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:29:0)
[15:51:21.094] Timer tick, asking Buildbucket for the build status
[15:51:21.380] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:21.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:30:0) after 1m0s
[15:52:21.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:30:0)
[15:52:21.455] Timer tick, asking Buildbucket for the build status
[15:52:21.637] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:21.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:31:0) after 1m0s
[15:53:21.713] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:31:0)
[15:53:21.713] Timer tick, asking Buildbucket for the build status
[15:53:21.783] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:21.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:32:0) after 1m0s
[15:54:21.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:32:0)
[15:54:21.818] Timer tick, asking Buildbucket for the build status
[15:54:21.978] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:21.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:33:0) after 1m0s
[15:55:22.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:33:0)
[15:55:22.112] Timer tick, asking Buildbucket for the build status
[15:55:22.776] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:22.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:34:0) after 1m0s
[15:56:22.866] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:34:0)
[15:56:22.866] Timer tick, asking Buildbucket for the build status
[15:56:23.025] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:23.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:35:0) after 1m0s
[15:57:23.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:35:0)
[15:57:23.288] Timer tick, asking Buildbucket for the build status
[15:57:23.457] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:23.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:36:0) after 1m0s
[15:58:23.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:36:0)
[15:58:23.513] Timer tick, asking Buildbucket for the build status
[15:58:23.770] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:23.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:37:0) after 1m0s
[15:59:23.907] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:37:0)
[15:59:23.907] Timer tick, asking Buildbucket for the build status
[15:59:24.125] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:24.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:38:0) after 1m0s
[16:00:24.145] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:38:0)
[16:00:24.145] Timer tick, asking Buildbucket for the build status
[16:00:24.741] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:24.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:39:0) after 1m0s
[16:01:24.868] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:39:0)
[16:01:24.868] Timer tick, asking Buildbucket for the build status
[16:01:24.993] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:24.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:40:0) after 1m0s
[16:02:25.080] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:40:0)
[16:02:25.081] Timer tick, asking Buildbucket for the build status
[16:02:25.765] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:25.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:41:0) after 1m0s
[16:03:25.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:41:0)
[16:03:25.846] Timer tick, asking Buildbucket for the build status
[16:03:25.944] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:25.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:42:0) after 1m0s
[16:04:26.011] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:42:0)
[16:04:26.011] Timer tick, asking Buildbucket for the build status
[16:04:26.816] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:26.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:43:0) after 1m0s
[16:05:26.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:43:0)
[16:05:26.860] Timer tick, asking Buildbucket for the build status
[16:05:27.278] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:27.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:44:0) after 1m0s
[16:06:27.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:44:0)
[16:06:27.327] Timer tick, asking Buildbucket for the build status
[16:06:27.437] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:27.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:45:0) after 1m0s
[16:07:27.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:45:0)
[16:07:27.459] Timer tick, asking Buildbucket for the build status
[16:07:27.799] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:27.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:46:0) after 1m0s
[16:08:27.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:46:0)
[16:08:27.791] Timer tick, asking Buildbucket for the build status
[16:08:27.898] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:27.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:47:0) after 1m0s
[16:09:27.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:47:0)
[16:09:27.920] Timer tick, asking Buildbucket for the build status
[16:09:28.187] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:28.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:48:0) after 1m0s
[16:10:28.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:48:0)
[16:10:28.234] Timer tick, asking Buildbucket for the build status
[16:10:28.493] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:28.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:49:0) after 1m0s
[16:11:28.584] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:49:0)
[16:11:28.584] Timer tick, asking Buildbucket for the build status
[16:11:28.670] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:28.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:50:0) after 1m0s
[16:12:28.723] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:50:0)
[16:12:28.723] Timer tick, asking Buildbucket for the build status
[16:12:29.124] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:29.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:51:0) after 1m0s
[16:13:29.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:51:0)
[16:13:29.178] Timer tick, asking Buildbucket for the build status
[16:13:29.317] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:29.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:52:0) after 1m0s
[16:14:29.422] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:52:0)
[16:14:29.422] Timer tick, asking Buildbucket for the build status
[16:14:29.668] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:29.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:53:0) after 1m0s
[16:15:29.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:53:0)
[16:15:29.747] Timer tick, asking Buildbucket for the build status
[16:15:29.845] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:29.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:54:0) after 1m0s
[16:16:29.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:54:0)
[16:16:29.898] Timer tick, asking Buildbucket for the build status
[16:16:29.974] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:29.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:55:0) after 1m0s
[16:17:29.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:55:0)
[16:17:29.999] Timer tick, asking Buildbucket for the build status
[16:17:30.083] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:30.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:56:0) after 1m0s
[16:18:30.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:56:0)
[16:18:30.178] Timer tick, asking Buildbucket for the build status
[16:18:30.340] Build 8861560205434340240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:30.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026990267538882544:57:0) after 1m0s
[16:19:27.676] Received PubSub notification, asking Buildbucket for the build status
[16:19:28.099] Build 8861560205434340240: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:19:28.099] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1607357966654189",
"created_by": "project:chromium",
"created_ts": "1607354650997430",
"id": "8861560205434340240",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e503e8800b78b0963b06a6c9867aede677da9dda\"}}",
"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}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$build/goma.jobs\", \"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"e503e8800b78b0963b06a6c9867aede677da9dda\", \"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-5-jjte\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16084, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"cf023b3a8cd1fdeba958849517eee411023c6ae8\", \"got_dawn_revision\": \"d63d562d1b26e01b369d9a58eddeaccfaa688a02\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"e503e8800b78b0963b06a6c9867aede677da9dda\", \"got_revision_cp\": \"refs/heads/master@{#834213}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"7c84426d2abe231f3087a2942fd831137eb3b0aa\", \"got_v8_revision\": \"61f3e61408129afc0d9e1268d3354a283ea3c881\", \"got_v8_revision_cp\": \"refs/heads/8.9.100@{#1}\", \"got_webrtc_revision\": \"ea969d287bfe6634c8925f34f9e7997d168dfca1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32784}\", \"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\": \"e503e8800b78b0963b06a6c9867aede677da9dda\", \"swarm_hashes_refs/heads/master(at){#834213}_without_patch\": {\"absl_hardening_tests\": \"63b88e47a41aef16fb3b54f1ec423142ea619109\", \"accessibility_unittests\": \"e7ee1bff18c2f93c3c212f00895484b0295e45da\", \"angle_unittests\": \"1b8227ede498fa04f458e613f51223a4157c094c\", \"app_shell_unittests\": \"657b8220b63abd1e5aad05024261d073c7a1e001\", \"aura_unittests\": \"435441d73414a10cb1f439d1a48d2891f9879d5d\", \"base_unittests\": \"a166249ffe67c5e243e25c6bd2cd6c65c0578d46\", \"base_util_unittests\": \"ee1007b0310e1d7a7d450e897d23c0509c1dc35f\", \"blink_common_unittests\": \"b3d89730a2d12ad048cd50867cb9d55f7b077382\", \"blink_fuzzer_unittests\": \"c786ebe9f79e53d8625840cfa0b431da12084d0d\", \"blink_heap_unittests\": \"93401429b57d71505e9ec2fe34586374da2e9ee0\", \"blink_platform_unittests\": \"df5df228ab753d9f8371307f68265c665819ec2e\", \"blink_unittests\": \"4bd1d70e6d9fa26eb9539be85cb05a7653d64d97\", \"boringssl_crypto_tests\": \"a0f8698ef186532823d1dd3381c6d2b123021d70\", \"boringssl_ssl_tests\": \"19b72fec7146a8d603e1712e8987fe2dd02c6532\", \"browser_switcher_bho_unittests\": \"fa6bd8fce8ea8b115da662775aed98df39b88ecb\", \"browser_tests\": \"b5cf7f36e1db5680aa403a6b2087311d31a87a98\", \"capture_unittests\": \"4fab70ba6378ddb1f82d78de6b7ac3a3a1ab29b3\", \"cast_unittests\": \"17ce57e2be9f3633342c09658307091de128fd9a\", \"cc_unittests\": \"bbe1a9589ec30af98e9965b0b91ecbb8dad38369\", \"chrome_app_unittests\": \"6c6f15b7a4d04177494fb896d7ceb941bc277dff\", \"chrome_cleaner_unittests\": \"15e5aef056cc32b2690041f5c9b9919e71d3e52a\", \"chrome_elf_unittests\": \"da4df5d09af597f47891ace99a3f330f1965fc04\", \"chromedriver_unittests\": \"9be24a3440f4777fc9e5a64367b5c60310e4757c\", \"components_browsertests\": \"3975516624d7fcd8bbe716e3271cfbbda829d16c\", \"components_unittests\": \"a9073b94738203c90ec66254e85ef7319c4e9142\", \"compositor_unittests\": \"86032592f715a41a37dad3491c953633a3adfdab\", \"content_browsertests\": \"208eb7e37a16dd1eab5cccdb82e92b56daf29fdb\", \"content_unittests\": \"d2a39102276f714bc3099e054a15bedd58363fc7\", \"courgette_unittests\": \"e95abef4ba108bc671fba3d252e82ba918b79e00\", \"crashpad_tests\": \"1f9e2ee0c35f4ba90f330c5ef4eec0cb39ae964a\", \"cronet_tests\": \"431c34b1998bcef7902dc7c5337d9f14afaaef0d\", \"cronet_unittests\": \"25f2bcbd2efdcd651552bd49cc95cc9ed91dd097\", \"crypto_unittests\": \"a616fe905aa27cbdaf80e43ad62fab27218178dc\", \"delayloads_unittests\": \"bc6a393b7cbb1d8956e4ce765ab07634d699ce70\", \"device_unittests\": \"38996784d1c137c06ecd9ea96892b62b44a02935\", \"display_unittests\": \"a9ddc8328078cb74cdd689b13150ddb31934d689\", \"elevation_service_unittests\": \"4eff00f4cb5417e5444ebaaa13406d76461d69ef\", \"events_unittests\": \"f289f07c395f572a8821f12b586fba1b415d8b4e\", \"extensions_browsertests\": \"f3715be1faaec1df87b3732c1ca7d1901fcc9f15\", \"extensions_unittests\": \"1daa11d10ce4ffd17b95ef61a9c748566a9dad56\", \"filesystem_service_unittests\": \"4325536f2f44086d28c4243aede2beb0a6c5a2a8\", \"gcm_unit_tests\": \"63d6aea8d9f3d3a302b19faa7ed3eda750f0888e\", \"gcp_unittests\": \"03454a71971443e05dd9af9ed26b63f1e2c8edcd\", \"gfx_unittests\": \"c930c3e1b50c056c0e11b8d523b96fc74b48125a\", \"gin_unittests\": \"7381882d18e043a717560ea17f9eeb84ccf4daf2\", \"google_apis_unittests\": \"cc9b763d8b01e12bc3c8071bae6443cb6354e22a\", \"gpu_unittests\": \"d2b4022344f7ca3760f7d658025a9456180189df\", \"gwp_asan_unittests\": \"4bcbf76086391f6012fdb52948e13ba7e1bd2ec6\", \"headless_browsertests\": \"6ad1635c07922e0ea95c84c537598bd5ad8d8b6b\", \"headless_unittests\": \"f181ad5da9930bb1eab3a1563357958214e287de\", \"install_static_unittests\": \"f697c4406258ee404aa02defa69325e848d17674\", \"installer_util_unittests\": \"b5a5fe531974b876591f783ceb5bd9d6ab17f555\", \"interactive_ui_tests\": \"63ce2e44d0456b2b9e88ed0bc812bcbb906570c3\", \"ipc_tests\": \"f1bd2b6d6d456325638255eb2bda6eb8028e19f9\", \"jingle_unittests\": \"21045a9e07db7046225d791b9119fb1afc099f4d\", \"latency_unittests\": \"f3f0120e96ad5ea5bdd4e0c90da85ecc66f7e374\", \"libjingle_xmpp_unittests\": \"af27b529a8175df7d580602dbf68717a7f36d070\", \"liburlpattern_unittests\": \"c187beb945f1623cad21b6f4b1deedd4544242fa\", \"media_blink_unittests\": \"5ed500371792d9e9a396326f7efa18c12ac6a597\", \"media_unittests\": \"42a177c156c98729eeaf6480792a93ea4e634010\", \"message_center_unittests\": \"ad8d74318971afcac4eff77f3f85941764e75562\", \"midi_unittests\": \"554fd07d8976f5734b49e9d9ae94f478b0b88bdf\", \"mojo_core_unittests\": \"b01643ef32e9da5d27ad7979042229d1c6c8bc29\", \"mojo_unittests\": \"324cddc1982f0ca93821126b0095b56bbe34ba51\", \"nacl_loader_unittests\": \"582172c5855cf101fc7187ee385b34e30fc29280\", \"native_theme_unittests\": \"2101afbc9843e6b60aed95ec219696c2881eacca\", \"net_unittests\": \"61c4d201634f5f79c1c856f2fef1555ef7e71c19\", \"notification_helper_unittests\": \"1109ed2aadcf0a411449151fdfd9c2e80966d61d\", \"pdf_unittests\": \"1d2587b9add71d58cc1895540e67fc86cc550c88\", \"perfetto_unittests\": \"7ab59422735d83b418c7f019e1770108758cacc8\", \"ppapi_unittests\": \"a53e118abb89077ec43c8ba9728df4248e28ad58\", \"printing_unittests\": \"b4ce78fa01bfa79f27faa4bfa342f3ebeaba8195\", \"remoting_unittests\": \"aa384993be4a4f33ffd748f79e08a564861b2a85\", \"sbox_integration_tests\": \"035d7be5c0e3ee8ce135ffce6803e49aa00428c4\", \"sbox_unittests\": \"9b6c01b85dbb681c892a38400d841c6bee964736\", \"sbox_validation_tests\": \"9933970aec975ca4d6bcfe39ef5fdd27941987d0\", \"service_manager_unittests\": \"92316f7ec2b23c6357cfc98f2eca9496880b69f8\", \"services_unittests\": \"e14464d9d7d1f2ba898ba5be32aff805820b2af3\", \"setup_unittests\": \"8eff24528d1ccd20ef5735539f68913379a0122a\", \"shell_dialogs_unittests\": \"0b21188004213a3f439524df024999f850abd82c\", \"skia_unittests\": \"a7ecba204528e35d8ef9845eb9454f238b4b10b3\", \"snapshot_unittests\": \"7e344aa0fcf7f4b324bfd6d80348c67afe16d39e\", \"sql_unittests\": \"cafaf138e9466008cad181ddcef514221a375aa9\", \"storage_unittests\": \"7b3614189c0c57c47b3f5d471a5d0381e9c99b09\", \"sync_integration_tests\": \"95f115be0d4d641830976d13f2f086d3fe958c06\", \"traffic_annotation_auditor_unittests\": \"4c988aee3b12ab430dd5dc2d387306d927705c33\", \"ui_base_unittests\": \"02ea78a9240b543f29ebf73b588a1a94a4bf31bb\", \"ui_touch_selection_unittests\": \"85f9019ac41abcac9fde059d5e4f04f84e77c6ed\", \"unit_tests\": \"c917d24614e34eda047a299aa3bbf7417c75b588\", \"updater_tests\": \"7c466fbf9af63f68149c0ebe556b501b340bfcb9\", \"url_unittests\": \"ec4e7a2764c0594249dfad9217c17e3bc5f3b92e\", \"views_unittests\": \"96b9321942c5440aa1f993253622d137b4de9b7f\", \"viz_unittests\": \"3e497e88d5917c8c2aead46795f156070920c48d\", \"vr_common_unittests\": \"bc9b70a8fe912e6a65b32eba5f7f03c712c72a62\", \"vr_pixeltests\": \"abb6c4986b7571cb23a7e736ad71d4d830788ac9\", \"weblayer_browsertests\": \"5a74056051deddf5b9886b2a9086341867566f31\", \"weblayer_unittests\": \"0c74b4133d98e31ff68063ac7f80417807f7d27a\", \"wm_unittests\": \"472207c14c9cd62d435dd6da27aff99499f53a5b\", \"wtf_unittests\": \"bc925d4abfac8428ca0c1fa1f828ac200d5191b0\", \"zlib_unittests\": \"c753ab8197d7fc888eb625aebb91a3c2d46d8de8\", \"zucchini_unittests\": \"322a0ad0de1e8477566d96132a7a9d92eef6f279\"}}, \"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-5-jjte\"], \"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": "1607354654264547",
"status": "COMPLETED",
"status_changed_ts": "1607357967343932",
"tags": [
"build_address:luci.chromium.ci/win-asan/16084",
"builder:win-asan",
"buildset:commit/git/e503e8800b78b0963b06a6c9867aede677da9dda",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e503e8800b78b0963b06a6c9867aede677da9dda",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026990267538882544",
"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/8861560205434340240/+/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:50569f20452dae10",
"user_agent:luci-scheduler"
],
"updated_ts": "1607357967348928",
"url": "https://ci.chromium.org/b/8861560205434340240",
"utcnow_ts": "1607357968066702"
}
}
[16:19:28.099] Invocation finished in 55m18.493113799s with status SUCCEEDED